Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

OCPP: Timeout on restart of evcc upon wallbox reconnection #15874

Closed
jeffborg opened this issue Sep 2, 2024 · 2 comments
Closed

OCPP: Timeout on restart of evcc upon wallbox reconnection #15874

jeffborg opened this issue Sep 2, 2024 · 2 comments

Comments

@jeffborg
Copy link
Contributor

jeffborg commented Sep 2, 2024

Describe the bug

wallbox firmware updated working fine, tested restarting evcc and does not start up. Need to powercycle both wallbox and restart evcc to get working. May be related to #15869

Steps to reproduce

  1. restart evcc
  2. when wallbox reconnects evcc times out.

Configuration details

chargers:
  - name: solax
    type: template
    template: ocpp
    timeout: 2m
    getconfiguration: false
    metervalues: Energy.Active.Import.Register,Power.Active.Import,Current.Import
    bootnotification: false
    meterinterval: 10s
    remotestart: true

Log details

[main  ] INFO 2024/09/03 08:38:49 evcc 0.136.6
[main  ] INFO 2024/09/03 08:38:49 using config file: /config/evcc.yaml
[db    ] INFO 2024/09/03 08:38:49 using sqlite database: /config/.evcc/evcc.db
[mqtt  ] INFO 2024/09/03 08:38:50 connecting evcc-497679395 at tcp://mqtt-mosquitto:1883
[mqtt  ] DEBUG 2024/09/03 08:38:50 tcp://mqtt-mosquitto:1883 connected
[main  ] INFO 2024/09/03 08:38:50 listening at :7070
[ocpp-1] DEBUG 2024/09/03 08:38:50 waiting for chargepoint: 5m0s
[ocpp  ] INFO 2024/09/03 08:39:01 charge point connected, registering: SN10052307203612
[ocpp  ] TRACE 2024/09/03 08:39:02 send SN10052307203612: [2,"3396786914","ChangeAvailability",{"connectorId":0,"type":"Operative"}]
[ocpp  ] TRACE 2024/09/03 08:39:02 recv SN10052307203612: [2,"475","DataTransfer",{"vendorId":"EN+","messageId":"gatewayInfo","data":"{\"SN\":\"SN10052307203612\",\"fwVer\":\"V43.2.636\",\"gateCode\":107,\"measureType\":1,\"disconnectReason\":0,\"maxCurr\":320,\"phase\":1,\"sdCardStatus\":0}"}]
[ocpp  ] TRACE 2024/09/03 08:39:02 send SN10052307203612: [3,"475",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:02 recv SN10052307203612: [2,"476","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:01Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Sample.Periodic"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.4","context":"Sample.Periodic"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Sample.Periodic"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Sample.Periodic"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:02 send SN10052307203612: [3,"476",{}]
[ocpp  ] TRACE 2024/09/03 08:39:05 recv SN10052307203612: [2,"477","Heartbeat",{}]
[ocpp  ] TRACE 2024/09/03 08:39:05 recv SN10052307203612: [3,"3396786914",{"status":"Rejected"}]
[ocpp-1] DEBUG 2024/09/03 08:39:05 failed configuring availability: Rejected
[ocpp  ] TRACE 2024/09/03 08:39:05 send SN10052307203612: [3,"477",{"currentTime":"2024-09-02T22:39:05Z"}]
[ocpp  ] TRACE 2024/09/03 08:39:05 send SN10052307203612: [2,"575591476","GetConfiguration",{}]
[ocpp  ] TRACE 2024/09/03 08:39:05 recv SN10052307203612: [2,"478","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":0,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":220,\"lockStatus\":1,\"ctCurrent\":9}"}]
[ocpp  ] TRACE 2024/09/03 08:39:05 send SN10052307203612: [3,"478",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:06 recv SN10052307203612: [3,"575591476",{"configurationKey":[{"key":"vendorId","value":"EN+","readonly":false},{"key":"chargePointSN","value":"","readonly":false},{"key":"AuthorizationKey","value":"ABCDEFGHIJ123456","readonly":false},{"key":"ChargingParametersEnabled","value":"true","readonly":false},{"key":"AllowOfflineTxForUnknownId","value":"false","readonly":false},{"key":"AuthorizationCacheEnabled","value":"false","readonly":false},{"key":"AuthorizeRemoteTxRequests","value":"false","readonly":false},{"key":"BlinkRepeat","value":"0","readonly":false},{"key":"ClockAlignedDataInterval","value":"0","readonly":false},{"key":"ConnectionTimeOut","value":"30","readonly":false},{"key":"GetConfigurationMaxKeys","value":"50","readonly":true},{"key":"HeartbeatInterval","value":"60","readonly":false},{"key":"LocalAuthorizeOffline","value":"false","readonly":false},{"key":"LocalPreAuthorize","value":"false","readonly":false},{"key":"MaxEnergyOnInvalidId","value":"3000","readonly":false},{"key":"MeterValuesAlignedData","value":"Energy.Active.Import.Register","readonly":false},{"key":"MeterValuesSampledData","value":"Energy.Active.Import.Register,Current.Import,Voltage,SoC,Power.Active.Import","readonly":false},{"key":"MeterValueSampleInterval","value":"60","readonly":false},{"key":"MinimumStatusDuration","value":"0","readonly":false},{"key":"ResetRetries","value":"0","readonly":false},{"key":"ConnectorPhaseRotation","value":"","readonly":false},{"key":"StopTransactionOnEVSideDisconnect","value":"false","readonly":false},{"key":"StopTransactionOnInvalidId","value":"false","readonly":false},{"key":"StopTxnAlignedData","value":"","readonly":false},{"key":"StopTxnSampledData","value":"Energy.Active.Import.Register","readonly":false},{"key":"TransactionMessageAttempts","value":"0","readonly":false},{"key":"TransactionMessageRetryInterval","value":"15","readonly":false},{"key":"UnlockConnectorOnEVSideDisconnect","value":"false","readonly":false},{"key":"WebSocketPingInterval","value":"0","readonly":false},{"key":"NumberOfConnectors","value":"1","readonly":true},{"key":"MeterValuesAlignedDataMaxLength","value":"120","readonly":true},{"key":"MeterValuesSampledDataMaxLength","value":"120","readonly":true},{"key":"ConnectorPhaseRotationMaxLength","value":"120","readonly":true},{"key":"StopTxnAlignedDataMaxLength","value":"120","readonly":true},{"key":"StopTxnSampledDataMaxLength","value":"120","readonly":true},{"key":"SupportedFeatureProfiles","value":"Core,Reservation,FirmwareManagement,LocalAuthListManagement,RemoteTrigger,SmartCharging","readonly":true},{"key":"SupportedFeatureProfilesMaxLength","value":"120","readonly":true},{"key":"ReserveConnectorZeroSupported","value":"false","readonly":true},{"key":"LocalAuthListEnabled","value":"true","readonly":false},{"key":"LocalAuthListMaxLength","value":"10","readonly":true},{"key":"SendLocalListMaxLength","value":"10","readonly":true},{"key":"ChargeProfileMaxStackLevel","value":"5","readonly":true},{"key":"ChargingScheduleAllowedChargingRateUnit","value":"Current","readonly":true},{"key":"ChargingScheduleMaxPeriods","value":"5","readonly":true},{"key":"ConnectorSwitch3to1PhaseSupported","value":"false","readonly":true},{"key":"MaxChargingProfilesInstalled","value":"3","readonly":true}],"unknownKey":[]}]
[ocpp  ] TRACE 2024/09/03 08:39:06 send SN10052307203612: [2,"3107247997","TriggerMessage",{"requestedMessage":"BootNotification"}]
[ocpp  ] TRACE 2024/09/03 08:39:06 recv SN10052307203612: [3,"3107247997",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:06 recv SN10052307203612: [2,"479","BootNotification",{"chargePointModel":"23","chargePointSerialNumber":"SN10052307203612","chargePointVendor":"EN+","firmwareVersion":"1.5.91"}]
[ocpp  ] TRACE 2024/09/03 08:39:06 send SN10052307203612: [3,"479",{"currentTime":"2024-09-02T22:39:06Z","interval":60,"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:06 send SN10052307203612: [2,"3733828879","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Power.Active.Import"}]
[ocpp  ] TRACE 2024/09/03 08:39:08 recv SN10052307203612: [3,"3733828879",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:08 send SN10052307203612: [2,"1760679551","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Energy.Active.Import.Register"}]
[ocpp  ] TRACE 2024/09/03 08:39:09 recv SN10052307203612: [3,"1760679551",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:09 send SN10052307203612: [2,"2098796689","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Current.Import"}]
[ocpp  ] TRACE 2024/09/03 08:39:09 recv SN10052307203612: [3,"2098796689",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:09 send SN10052307203612: [2,"507748885","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Voltage"}]
[ocpp  ] TRACE 2024/09/03 08:39:10 recv SN10052307203612: [3,"507748885",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:10 send SN10052307203612: [2,"4005503876","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Current.Offered"}]
[ocpp  ] TRACE 2024/09/03 08:39:11 recv SN10052307203612: [3,"4005503876",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:11 send SN10052307203612: [2,"2088164538","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Power.Offered"}]
[ocpp  ] TRACE 2024/09/03 08:39:12 recv SN10052307203612: [3,"2088164538",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:12 send SN10052307203612: [2,"737847056","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"SoC"}]
[ocpp  ] TRACE 2024/09/03 08:39:13 recv SN10052307203612: [3,"737847056",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:13 send SN10052307203612: [2,"1400006221","ChangeConfiguration",{"key":"MeterValuesSampledData","value":"Power.Active.Import,Energy.Active.Import.Register,Current.Import,Voltage,Current.Offered,Power.Offered,SoC"}]
[ocpp  ] TRACE 2024/09/03 08:39:14 recv SN10052307203612: [3,"1400006221",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:14 send SN10052307203612: [2,"3904974401","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:39:14 recv SN10052307203612: [3,"3904974401",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:14 send SN10052307203612: [2,"3491560900","ChangeConfiguration",{"key":"MeterValueSampleInterval","value":"10"}]
[ocpp  ] TRACE 2024/09/03 08:39:14 recv SN10052307203612: [2,"480","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:13Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.4","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:14 send SN10052307203612: [3,"480",{}]
[ocpp  ] TRACE 2024/09/03 08:39:16 recv SN10052307203612: [3,"3491560900",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:16 recv SN10052307203612: [2,"481","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":256,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":256,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":220,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:39:16 send SN10052307203612: [2,"1411483424","ChangeConfiguration",{"key":"WebSocketPingInterval","value":"30"}]
[ocpp  ] TRACE 2024/09/03 08:39:16 send SN10052307203612: [3,"481",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:18 recv SN10052307203612: [3,"1411483424",{"status":"NotSupported"}]
[ocpp  ] TRACE 2024/09/03 08:39:24 send SN10052307203612: [2,"1419846836","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:39:26 recv SN10052307203612: [3,"1419846836",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:26 recv SN10052307203612: [2,"482","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:23Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.4","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:26 send SN10052307203612: [2,"1199472704","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:39:26 send SN10052307203612: [3,"482",{}]
[ocpp  ] TRACE 2024/09/03 08:39:28 recv SN10052307203612: [3,"1199472704",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:28 recv SN10052307203612: [2,"483","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:25Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.4","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:28 recv SN10052307203612: [2,"484","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":256,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":0,\"ccVolt\":256,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":9}"}]
[ocpp  ] TRACE 2024/09/03 08:39:28 send SN10052307203612: [3,"484",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:28 send SN10052307203612: [3,"483",{}]
[ocpp  ] TRACE 2024/09/03 08:39:28 recv SN10052307203612: [2,"485","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:39:28 send SN10052307203612: [3,"485",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:36 send SN10052307203612: [2,"3154436392","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:39:37 recv SN10052307203612: [3,"3154436392",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:37 recv SN10052307203612: [2,"486","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:35Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.4","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:37 send SN10052307203612: [3,"486",{}]
[ocpp  ] TRACE 2024/09/03 08:39:38 recv SN10052307203612: [2,"487","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:39:38 send SN10052307203612: [3,"487",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:46 recv SN10052307203612: [2,"488","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:44Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Sample.Periodic"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Sample.Periodic"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Sample.Periodic"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Sample.Periodic"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:46 send SN10052307203612: [3,"488",{}]
[ocpp  ] TRACE 2024/09/03 08:39:47 recv SN10052307203612: [2,"489","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:39:47 send SN10052307203612: [3,"489",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:54 send SN10052307203612: [2,"1679140935","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:39:56 recv SN10052307203612: [3,"1679140935",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:39:56 recv SN10052307203612: [2,"490","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:39:53Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:39:56 send SN10052307203612: [3,"490",{}]
[ocpp  ] TRACE 2024/09/03 08:39:56 recv SN10052307203612: [2,"491","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":256,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":256,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:39:56 send SN10052307203612: [3,"491",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:01 recv SN10052307203612: [2,"492","Heartbeat",{}]
[ocpp  ] TRACE 2024/09/03 08:40:01 send SN10052307203612: [3,"492",{"currentTime":"2024-09-02T22:40:01Z"}]
[ocpp  ] TRACE 2024/09/03 08:40:04 send SN10052307203612: [2,"3484462121","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:06 recv SN10052307203612: [3,"3484462121",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:06 recv SN10052307203612: [2,"493","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:03Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:06 send SN10052307203612: [3,"493",{}]
[ocpp  ] TRACE 2024/09/03 08:40:06 recv SN10052307203612: [2,"494","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":0,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":9}"}]
[ocpp  ] TRACE 2024/09/03 08:40:06 send SN10052307203612: [3,"494",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:14 send SN10052307203612: [2,"2611585181","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:14 recv SN10052307203612: [3,"2611585181",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:16 send SN10052307203612: [2,"4274647978","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:16 recv SN10052307203612: [2,"495","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:13Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:16 send SN10052307203612: [3,"495",{}]
[ocpp  ] TRACE 2024/09/03 08:40:16 recv SN10052307203612: [3,"4274647978",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:18 recv SN10052307203612: [2,"496","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:15Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:18 recv SN10052307203612: [2,"497","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":256,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":256,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:40:18 send SN10052307203612: [3,"496",{}]
[ocpp  ] TRACE 2024/09/03 08:40:18 send SN10052307203612: [3,"497",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:19 recv SN10052307203612: [2,"498","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":0,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":9}"}]
[ocpp  ] TRACE 2024/09/03 08:40:19 send SN10052307203612: [3,"498",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:26 send SN10052307203612: [2,"666249851","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:28 recv SN10052307203612: [3,"666249851",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:28 recv SN10052307203612: [2,"499","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:26Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:28 send SN10052307203612: [3,"499",{}]
[ocpp  ] TRACE 2024/09/03 08:40:30 recv SN10052307203612: [2,"500","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:40:30 send SN10052307203612: [3,"500",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:36 send SN10052307203612: [2,"3963483659","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:37 recv SN10052307203612: [3,"3963483659",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:38 send SN10052307203612: [2,"1471918389","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:38 recv SN10052307203612: [2,"501","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:35Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:38 send SN10052307203612: [3,"501",{}]
[ocpp  ] TRACE 2024/09/03 08:40:40 recv SN10052307203612: [3,"1471918389",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:40 recv SN10052307203612: [2,"502","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:37Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.2","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:40 recv SN10052307203612: [2,"503","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":0,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":9}"}]
[ocpp  ] TRACE 2024/09/03 08:40:40 send SN10052307203612: [3,"503",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:40 send SN10052307203612: [3,"502",{}]
[ocpp  ] TRACE 2024/09/03 08:40:41 recv SN10052307203612: [2,"504","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:40:41 send SN10052307203612: [3,"504",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:46 recv SN10052307203612: [2,"505","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:45Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Sample.Periodic"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.6","context":"Sample.Periodic"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Sample.Periodic"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Sample.Periodic"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:46 send SN10052307203612: [3,"505",{}]
[ocpp  ] TRACE 2024/09/03 08:40:47 recv SN10052307203612: [2,"506","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:40:47 send SN10052307203612: [3,"506",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:56 send SN10052307203612: [2,"2068749464","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:56 recv SN10052307203612: [3,"2068749464",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:40:58 send SN10052307203612: [2,"1438130917","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:40:58 recv SN10052307203612: [2,"507","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:55Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.6","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:40:58 send SN10052307203612: [3,"507",{}]
[ocpp  ] TRACE 2024/09/03 08:40:59 recv SN10052307203612: [3,"1438130917",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:41:00 recv SN10052307203612: [2,"508","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:40:57Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.6","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:41:00 recv SN10052307203612: [2,"509","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":256,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":256,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:41:00 send SN10052307203612: [3,"508",{}]
[ocpp  ] TRACE 2024/09/03 08:41:00 send SN10052307203612: [3,"509",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:41:01 recv SN10052307203612: [2,"510","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":1,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":12}"}]
[ocpp  ] TRACE 2024/09/03 08:41:01 send SN10052307203612: [3,"510",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:41:03 recv SN10052307203612: [2,"511","Heartbeat",{}]
[ocpp  ] TRACE 2024/09/03 08:41:03 send SN10052307203612: [3,"511",{"currentTime":"2024-09-02T22:41:03Z"}]
[ocpp  ] TRACE 2024/09/03 08:41:08 send SN10052307203612: [2,"1533328915","TriggerMessage",{"requestedMessage":"MeterValues","connectorId":1}]
[ocpp  ] TRACE 2024/09/03 08:41:10 recv SN10052307203612: [3,"1533328915",{"status":"Accepted"}]
[ocpp  ] TRACE 2024/09/03 08:41:10 recv SN10052307203612: [2,"512","MeterValues",{"connectorId":1,"meterValue":[{"timestamp":"2024-09-02T22:41:07Z","sampledValue":[{"measurand":"Current.Offered","unit":"A","value":"32.0","context":"Trigger"},{"measurand":"Current.Import","unit":"A","phase":"L1","value":"0.0"},{"measurand":"Voltage","unit":"V","phase":"L1","value":"246.6","context":"Trigger"},{"measurand":"Energy.Active.Import.Register","unit":"Wh","value":"95.0","context":"Trigger"},{"measurand":"Power.Active.Import","unit":"W","value":"0.0","context":"Trigger"}]}],"transactionId":9}]
[ocpp  ] TRACE 2024/09/03 08:41:10 send SN10052307203612: [3,"512",{}]
[ocpp  ] TRACE 2024/09/03 08:41:10 recv SN10052307203612: [2,"513","DataTransfer",{"vendorId":"EN+","messageId":"cpChargingParameterRpt","data":"{\"duty\":0,\"cpVolt\":931,\"transactionId\":9,\"totalPowerFactor\":259,\"aPhasesPowerFactor\":0,\"bPhasesPowerFactor\":6,\"cPhasesPowerFactor\":0,\"ccVolt\":259,\"offset0\":2010,\"offset1\":2019,\"leakcurr\":0,\"AMBTemp\":221,\"lockStatus\":1,\"ctCurrent\":9}"}]
[ocpp  ] TRACE 2024/09/03 08:41:10 send SN10052307203612: [3,"513",{"status":"Accepted"}]
[main  ] FATAL 2024/09/03 08:41:18 cannot create charger 'solax': cannot create charger type 'template': cannot create charger type 'ocpp': timeout
[main  ] FATAL 2024/09/03 08:41:18 will attempt restart in: 15m0s

What type of operating system are you running?

Linux

Version

0.136.6
@evcc-io evcc-io deleted a comment Sep 2, 2024
@premultiply
Copy link
Member

premultiply commented Sep 2, 2024 •
edited
Loading

Reason: StatusNotification is not sent by charge point and not triggered.

Please try with Version >= 0.130.7

Should be already fixed by
f5547ba Ocpp: do not return error on setup (#15853)
e6d3ad3 Ocpp: initial StatusNotification trigger request (#15734)
71f58e9 Ocpp: provide better support multiple connectors (#15762)

You should always avoid to add additional config options.
Most of them are useless (and deprecated) or could make things even worse.

chargers:
  - name: solax
    type: template
    template: ocpp

If this is still not working please report back.

@jeffborg
Copy link
Contributor Author

jeffborg commented Sep 3, 2024 •
edited by premultiply
Loading

@premultiply just took 0.130.7 + my hack for the unplug/replug issue and yes the request to get status notification works 👍 Cross fingers today during pv charging the evse stays online without having to power cycling it with the new firmware.

Also reduced config but left in remotestart: true for now, I will check the new firmware if plug and charge mode keeps the ocpp connection alive tonight.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@jeffborg @premultiply