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: Vehicle that had been manually assigned in the UI is assigned to different charger during identification phase #13862

Open
jduar opened this issue May 10, 2024 · 1 comment
Open

OCPP: Vehicle that had been manually assigned in the UI is assigned to different charger during identification phase #13862

jduar opened this issue May 10, 2024 · 1 comment
Labels
question Rather clarification than issue

Comments

@jduar
Copy link

jduar commented May 10, 2024

Describe the bug

On a setup with multiple vehicles and multiple chargers - but only one configured vehicle connected, the rest being guests - I had an issue where shortly after a restart, I had to manually assign the configured vehicle to its correct loadpoint.

Shortly after, evcc assigned that same vehicle to a different charger even though I had already manually assigned it using the UI. In the UI, the vehicle appeared as assigned to two chargers simultaneously. I unassigned it from the wrong charger - while leaving it assigned in the correct one - and shortly afterwards it was automatically assigned to another charger. Again, it appeared as assigned to two chargers in the UI.

There seem to actually be two errors in this behaviour:

  • the manual vehicle assignment I did in the UI was ignored during vehicle identification phase, so the vehicle was reassigned to a different charger despite me having already assigned it manually;
  • on the side of the UI, the vehicle was treated as if it was assigned to two chargers simultaneously.

I'll leave a better description below along with the logs, as it's easier to explain the chain of events.

Steps to reproduce

  1. Have multiple chargers
  2. Have one connected configured vehicle, and other connected guest vehicles
  3. After manually assigning the configured vehicles, evcc still assigned it to other chargers.

Configuration details

network:
  schema: http
  host: evcc
  port: 7070

interval: 30s # control cycle interval. Interval <30s can lead to unexpected behavior, see https://docs.evcc.io/en/docs/reference/configuration/interval/

log: debug
levels:
  site: debug
  lp-1: trace
  lp-2: trace
  cache: error
  db: error
  ocpp: trace
  flobz: trace

site:
  - title: Something
    meters:
      grid: grid
    residualPower: 0
    maxGridSupplyWhileBatteryCharging: 0

meters:
  - name: grid
    type: template
    template: huawei-smartlogger
    usage: grid

    modbus: tcpip
    id: 11
    host: 10.10.6.8
    port: 502

  - name: pv
    type: template
    template: huawei-sun2000-rs485
    usage: pv

    modbus: tcpip
    id: 1
    host: 10.10.6.8
    port: 502

chargers:
  - name: charger1
    type: template
    template: pulsarplus
    timeout: 2m
    stationid: charger1

  - name: charger2
    type: template
    template: pulsarplus
    timeout: 2m
    stationid: charger2

  - name: charger3
    type: template
    template: pulsarplus
    timeout: 2m
    stationid: charger3
    
  - name: charger4
    type: template
    template: pulsarplus
    timeout: 2m
    stationid: charger4

  - name: charger5
    type: template
    template: pulsarplus
    timeout: 2m
    stationid: charger5

  - name: charger6
    type: template
    template: pulsarplus
    timeout: 2m
    stationid: charger6

loadpoints:
  - title: Garage Charger 1
    charger: charger1
    mode: "now"

  - title: Garage Charger 2
    charger: charger2
    mode: "now"

  - title: Garage Charger 3
    charger: charger3
    mode: "now"

  - title: Garage Charger 4
    charger: charger4
    mode: "now"

  - title: Garage Charger 5
    charger: charger5
    mode: "now"

  - title: Garage Charger 6
    charger: charger6
    mode: "now"

vehicles:
  - name: blc
    type: template
    template: flobz
    title: blc
    url: url
    vin: VIN

  - name: sfr
    type: template
    template: flobz
    title: sfr
    url: url
    vin: VIN

Log details

// Restarted evcc successfully  

[site  ] INFO 2024/05/10 11:32:01 site config:
[site  ] INFO 2024/05/10 11:32:01   meters:      grid ✓ pv ✗ battery ✗
[site  ] INFO 2024/05/10 11:32:01     grid:      power ✓ energy ✓ currents ✓
[site  ] INFO 2024/05/10 11:32:01   vehicles:
[site  ] INFO 2024/05/10 11:32:01     vehicle 1: range ✓ finish ✗ status ✓ climate ✓ wakeup ✓
[site  ] INFO 2024/05/10 11:32:01     vehicle 2: range ✓ finish ✗ status ✓ climate ✓ wakeup ✓
[lp-1  ] INFO 2024/05/10 11:32:01 loadpoint 1:
[lp-1  ] INFO 2024/05/10 11:32:01   mode:        now
[lp-1  ] INFO 2024/05/10 11:32:01   charger:     power ✗ energy ✓ currents ✗ phases ✗ wakeup ✗
[lp-1  ] INFO 2024/05/10 11:32:01   meters:      charge ✗
[lp-2  ] INFO 2024/05/10 11:32:01 loadpoint 2:
[lp-2  ] INFO 2024/05/10 11:32:01   mode:        now
[lp-2  ] INFO 2024/05/10 11:32:01   charger:     power ✗ energy ✓ currents ✗ phases ✗ wakeup ✗
[lp-2  ] INFO 2024/05/10 11:32:01   meters:      charge ✗
[lp-3  ] INFO 2024/05/10 11:32:01 loadpoint 3:
[lp-3  ] INFO 2024/05/10 11:32:01   mode:        now
[lp-3  ] INFO 2024/05/10 11:32:01   charger:     power ✗ energy ✓ currents ✗ phases ✗ wakeup ✗
[lp-3  ] INFO 2024/05/10 11:32:01   meters:      charge ✗
[lp-4  ] INFO 2024/05/10 11:32:01 loadpoint 4:
[lp-4  ] INFO 2024/05/10 11:32:01   mode:        now
[lp-4  ] INFO 2024/05/10 11:32:01   charger:     power ✗ energy ✓ currents ✗ phases ✗ wakeup ✗
[lp-4  ] INFO 2024/05/10 11:32:01   meters:      charge ✗
[lp-5  ] INFO 2024/05/10 11:32:01 loadpoint 5:
[lp-5  ] INFO 2024/05/10 11:32:01   mode:        now
[lp-5  ] INFO 2024/05/10 11:32:01   charger:     power ✗ energy ✓ currents ✗ phases ✗ wakeup ✗
[lp-5  ] INFO 2024/05/10 11:32:01   meters:      charge ✗
[lp-6  ] INFO 2024/05/10 11:32:01 loadpoint 6:
[lp-6  ] INFO 2024/05/10 11:32:01   mode:        now
[lp-6  ] INFO 2024/05/10 11:32:01   charger:     power ✗ energy ✓ currents ✗ phases ✗ wakeup ✗
[lp-6  ] INFO 2024/05/10 11:32:01   meters:      charge ✗
[lp-1  ] DEBUG 2024/05/10 11:32:01 phase timer inactive
[lp-1  ] DEBUG 2024/05/10 11:32:01 pv timer inactive
[lp-2  ] DEBUG 2024/05/10 11:32:01 phase timer inactive
[lp-2  ] DEBUG 2024/05/10 11:32:01 pv timer inactive
[lp-3  ] DEBUG 2024/05/10 11:32:01 phase timer inactive
[lp-3  ] DEBUG 2024/05/10 11:32:01 pv timer inactive
[lp-4  ] DEBUG 2024/05/10 11:32:01 phase timer inactive
[lp-4  ] DEBUG 2024/05/10 11:32:01 pv timer inactive
[lp-5  ] DEBUG 2024/05/10 11:32:01 phase timer inactive
[lp-5  ] DEBUG 2024/05/10 11:32:01 pv timer inactive
[lp-6  ] DEBUG 2024/05/10 11:32:01 phase timer inactive
[lp-6  ] DEBUG 2024/05/10 11:32:01 pv timer inactive
[site  ] DEBUG 2024/05/10 11:32:01 ----
[lp-1  ] DEBUG 2024/05/10 11:32:01 charge power: 0W
[lp-2  ] DEBUG 2024/05/10 11:32:01 charge power: 0W
[lp-3  ] DEBUG 2024/05/10 11:32:01 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:32:01 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:32:01 charge power: 0W
[lp-6  ] DEBUG 2024/05/10 11:32:01 charge power: 0W
[ocpp  ] TRACE 2024/05/10 11:32:01 received JSON message from charger4: [3,"2201553130",{"status": "Accepted"}]
[ocpp  ] TRACE 2024/05/10 11:32:01 TriggerMessage MeterValues for charger4: Accepted
[ocpp  ] TRACE 2024/05/10 11:32:01 received JSON message from charger4: [2,"1531310728","MeterValues",{"meterValue": [{"timestamp": "2024-05-10T09:32:00Z","sampledValue": [{"format": "Raw","location": "Outlet","context": "Trigger","measurand": "Energy.Active.Import.Register","unit": "Wh","value": "3177228.0"} ]} ],"connectorId": 1}]
[ocpp  ] TRACE 2024/05/10 11:32:01 sent JSON message to charger4: [3,"1531310728",{}]
[site  ] DEBUG 2024/05/10 11:32:02 grid meter: 16195W
[site  ] DEBUG 2024/05/10 11:32:02 grid currents: [33.6 11.6 22.6]A
[site  ] DEBUG 2024/05/10 11:32:02 pv power: 0W
[site  ] DEBUG 2024/05/10 11:32:02 site power: 16195W
[lp-1  ] DEBUG 2024/05/10 11:32:02 charger status: C
[lp-1  ] INFO 2024/05/10 11:32:02 car connected
[lp-1  ] DEBUG 2024/05/10 11:32:02 vehicle api refresh
[lp-1  ] DEBUG 2024/05/10 11:32:02 pv timer elapse
[lp-1  ] DEBUG 2024/05/10 11:32:02 pv timer inactive
[lp-1  ] INFO 2024/05/10 11:32:02 start charging ->
[lp-1  ] DEBUG 2024/05/10 11:32:02 wake-up timer: stop
[main  ] DEBUG 2024/05/10 11:32:02 vehicle status: C (blc)
[main  ] DEBUG 2024/05/10 11:32:02 vehicle status: A (sfr)

// blc vehicle is assigned to charger1 - which is expected, as it's the only configured vehicle with the status C. however, it is physically connected to charger5

[lp-1  ] INFO 2024/05/10 11:32:02 vehicle updated: unknown -> blc
[lp-1  ] DEBUG 2024/05/10 11:32:02 vehicle soc: 87%
[lp-1  ] DEBUG 2024/05/10 11:32:02 vehicle range: 298km
[lp-1  ] WARN 2024/05/10 11:32:02 charger logic error: disabled but charging
[lp-1  ] DEBUG 2024/05/10 11:32:02 charger enable
[ocpp  ] TRACE 2024/05/10 11:32:02 sent JSON message to charger1: [2,"2155845491","SetChargingProfile",{"connectorId":1,"csChargingProfiles":{"chargingProfileId":1,"transactionId":3,"stackLevel":0,"chargingProfilePurpose":"TxProfile","chargingProfileKind":"Relative","chargingSchedule":{"chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":17}]}}}]
[ocpp  ] TRACE 2024/05/10 11:32:03 received JSON message from charger1: [3,"2155845491",{"status": "Accepted"}]
[lp-1  ] DEBUG 2024/05/10 11:32:03 max charge current: 17A
[ocpp  ] TRACE 2024/05/10 11:32:06 received JSON message from charger1: [2,"718504052","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:32:06 sent JSON message to charger1: [3,"718504052",{"currentTime":"2024-05-10T09:32:06Z"}]
[ocpp  ] TRACE 2024/05/10 11:32:12 received JSON message from charger6: [2,"1105221355","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:32:12 sent JSON message to charger6: [3,"1105221355",{"currentTime":"2024-05-10T09:32:12Z"}]
[ocpp  ] TRACE 2024/05/10 11:32:19 received JSON message from charger4: [2,"2076875234","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:32:19 sent JSON message to charger4: [3,"2076875234",{"currentTime":"2024-05-10T09:32:19Z"}]
[site  ] DEBUG 2024/05/10 11:32:31 ----
[lp-1  ] DEBUG 2024/05/10 11:32:31 charge power: 3910W
[lp-2  ] DEBUG 2024/05/10 11:32:31 charge power: 0W
[lp-3  ] DEBUG 2024/05/10 11:32:31 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:32:31 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:32:31 charge power: 0W
[lp-6  ] DEBUG 2024/05/10 11:32:31 charge power: 0W
[site  ] DEBUG 2024/05/10 11:32:31 grid meter: 16053W
[site  ] DEBUG 2024/05/10 11:32:31 grid currents: [33.9 11.8 21.8]A
[site  ] DEBUG 2024/05/10 11:32:31 pv power: 0W
[site  ] DEBUG 2024/05/10 11:32:31 site power: 16053W
[lp-2  ] DEBUG 2024/05/10 11:32:31 charger status: C
[lp-2  ] INFO 2024/05/10 11:32:31 car connected
[lp-2  ] DEBUG 2024/05/10 11:32:31 vehicle api refresh
[lp-2  ] DEBUG 2024/05/10 11:32:31 pv timer elapse
[lp-2  ] DEBUG 2024/05/10 11:32:31 pv timer inactive
[lp-2  ] INFO 2024/05/10 11:32:31 start charging ->
[lp-2  ] DEBUG 2024/05/10 11:32:31 wake-up timer: stop
[main  ] DEBUG 2024/05/10 11:32:31 vehicle status: A (sfr)
[lp-2  ] WARN 2024/05/10 11:32:31 charger logic error: disabled but charging
[lp-2  ] DEBUG 2024/05/10 11:32:31 charger enable
[ocpp  ] TRACE 2024/05/10 11:32:31 sent JSON message to charger2: [2,"3861516104","SetChargingProfile",{"connectorId":1,"csChargingProfiles":{"chargingProfileId":1,"transactionId":2,"stackLevel":0,"chargingProfilePurpose":"TxProfile","chargingProfileKind":"Relative","chargingSchedule":{"chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":17}]}}}]
[ocpp  ] TRACE 2024/05/10 11:32:32 received JSON message from charger2: [3,"3861516104",{"status": "Accepted"}]
[lp-2  ] DEBUG 2024/05/10 11:32:32 max charge current: 17A
[ocpp  ] TRACE 2024/05/10 11:32:35 received JSON message from charger2: [2,"32748414","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:32:35 sent JSON message to charger2: [3,"32748414",{"currentTime":"2024-05-10T09:32:35Z"}]
[ocpp  ] TRACE 2024/05/10 11:32:50 received JSON message from charger5: [2,"1958103345","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:32:50 sent JSON message to charger5: [3,"1958103345",{"currentTime":"2024-05-10T09:32:50Z"}]
[ocpp  ] TRACE 2024/05/10 11:32:53 received JSON message from charger3: [2,"1211108051","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:32:53 sent JSON message to charger3: [3,"1211108051",{"currentTime":"2024-05-10T09:32:53Z"}]
[site  ] DEBUG 2024/05/10 11:33:01 ----
[lp-1  ] DEBUG 2024/05/10 11:33:01 charge power: 3910W
[lp-2  ] DEBUG 2024/05/10 11:33:01 charge power: 3910W
[lp-3  ] DEBUG 2024/05/10 11:33:01 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:33:01 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:33:01 charge power: 0W
[lp-6  ] DEBUG 2024/05/10 11:33:01 charge power: 0W
[site  ] DEBUG 2024/05/10 11:33:01 grid meter: 15443W
[site  ] DEBUG 2024/05/10 11:33:01 grid currents: [33.7 11.6 19.5]A
[site  ] DEBUG 2024/05/10 11:33:01 pv power: 0W
[site  ] DEBUG 2024/05/10 11:33:01 site power: 15443W
[lp-3  ] DEBUG 2024/05/10 11:33:01 charger status: B
[lp-3  ] INFO 2024/05/10 11:33:01 car connected
[lp-3  ] DEBUG 2024/05/10 11:33:01 vehicle api refresh
[lp-3  ] DEBUG 2024/05/10 11:33:01 pv timer elapse
[lp-3  ] DEBUG 2024/05/10 11:33:01 pv timer inactive
[main  ] DEBUG 2024/05/10 11:33:01 vehicle status: A (sfr)
[lp-3  ] DEBUG 2024/05/10 11:33:01 max charge current: 6A
[lp-3  ] DEBUG 2024/05/10 11:33:01 charger enable
[lp-3  ] DEBUG 2024/05/10 11:33:01 wake-up timer: start
[ocpp  ] TRACE 2024/05/10 11:33:06 received JSON message from charger1: [2,"229193316","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:33:06 sent JSON message to charger1: [3,"229193316",{"currentTime":"2024-05-10T09:33:06Z"}]

// here I manually unassign blc from charger1 and assign it to charger5 in the UI (since I know that's its correct position)

[lp-1  ] INFO 2024/05/10 11:33:12 vehicle updated: blc -> unknown
[lp-5  ] INFO 2024/05/10 11:33:12 vehicle updated: unknown -> blc
[ocpp  ] TRACE 2024/05/10 11:33:12 received JSON message from charger6: [2,"192677344","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:33:12 sent JSON message to charger6: [3,"192677344",{"currentTime":"2024-05-10T09:33:12Z"}]
[ocpp  ] TRACE 2024/05/10 11:33:19 received JSON message from charger4: [2,"157973909","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:33:19 sent JSON message to charger4: [3,"157973909",{"currentTime":"2024-05-10T09:33:19Z"}]
[site  ] DEBUG 2024/05/10 11:33:31 ----
[lp-1  ] DEBUG 2024/05/10 11:33:31 charge power: 3910W
[lp-2  ] DEBUG 2024/05/10 11:33:31 charge power: 3910W
[lp-3  ] DEBUG 2024/05/10 11:33:31 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:33:31 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:33:31 charge power: 0W
[lp-6  ] DEBUG 2024/05/10 11:33:31 charge power: 0W
[site  ] DEBUG 2024/05/10 11:33:31 grid meter: 15455W
[site  ] DEBUG 2024/05/10 11:33:31 grid currents: [33.7 11.6 19.5]A
[site  ] DEBUG 2024/05/10 11:33:31 pv power: 0W
[site  ] DEBUG 2024/05/10 11:33:31 site power: 15455W
[lp-4  ] DEBUG 2024/05/10 11:33:31 charger status: B
[lp-4  ] INFO 2024/05/10 11:33:31 car connected
[lp-4  ] DEBUG 2024/05/10 11:33:31 vehicle api refresh
[lp-4  ] DEBUG 2024/05/10 11:33:31 pv timer elapse
[lp-4  ] DEBUG 2024/05/10 11:33:31 pv timer inactive
[main  ] DEBUG 2024/05/10 11:33:31 vehicle status: C (blc)
[main  ] DEBUG 2024/05/10 11:33:31 vehicle status: A (sfr)

// blc vehicle is automatically assigned to charger4 even though I had manually assigned it to 5 in the UI
// in the UI, the same vehicle (blc) appears as assigned to both chargers 4 and 5 (I thought I had taken a screenshot but apparently didn't, sorry)

[lp-4  ] INFO 2024/05/10 11:33:31 vehicle updated: unknown -> blc
[lp-4  ] DEBUG 2024/05/10 11:33:31 vehicle soc: 87%
[lp-4  ] DEBUG 2024/05/10 11:33:31 vehicle range: 298km
[lp-4  ] DEBUG 2024/05/10 11:33:31 max charge current: 6A
[ocpp  ] TRACE 2024/05/10 11:33:31 sent JSON message to charger4: [2,"361345635","RemoteStartTransaction",{"connectorId":1,"idTag":"evcc","chargingProfile":{"chargingProfileId":1,"stackLevel":0,"chargingProfilePurpose":"TxProfile","chargingProfileKind":"Relative","chargingSchedule":{"chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":6}]}}}]
[ocpp  ] TRACE 2024/05/10 11:33:32 received JSON message from charger4: [3,"361345635",{"status": "Accepted"}]
[lp-4  ] DEBUG 2024/05/10 11:33:32 charger enable
[lp-4  ] DEBUG 2024/05/10 11:33:32 wake-up timer: start
[ocpp  ] TRACE 2024/05/10 11:33:33 received JSON message from charger4: [2,"1690828371","StatusNotification",{"info": "","vendorId": "com.wallbox","vendorErrorCode": "","connectorId": 1,"errorCode": "NoError","status": "SuspendedEV","timestamp": "2024-05-10T09:33:32Z"}]
[ocpp  ] TRACE 2024/05/10 11:33:33 sent JSON message to charger4: [3,"1690828371",{}]
[ocpp  ] TRACE 2024/05/10 11:33:33 received JSON message from charger4: [2,"1557620404","StartTransaction",{"connectorId": 1,"meterStart": 3177227,"idTag": "evcc","timestamp": "2024-05-10T09:33:32Z"}]
[ocpp  ] TRACE 2024/05/10 11:33:33 sent JSON message to charger4: [3,"1557620404",{"idTagInfo":{"status":"Accepted"},"transactionId":1}]
[ocpp  ] TRACE 2024/05/10 11:33:36 received JSON message from charger2: [2,"1672033788","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:33:36 sent JSON message to charger2: [3,"1672033788",{"currentTime":"2024-05-10T09:33:36Z"}]
[ocpp  ] TRACE 2024/05/10 11:33:38 received JSON message from charger4: [2,"125929321","StatusNotification",{"info": "","vendorId": "com.wallbox","vendorErrorCode": "","connectorId": 1,"errorCode": "NoError","status": "Charging","timestamp": "2024-05-10T09:33:37Z"}]
[ocpp  ] TRACE 2024/05/10 11:33:38 sent JSON message to charger4: [3,"125929321",{}]

// here I noticed that blc had been wrongly assigned to charger4 and changed it to 'guest vehicle' in the UI
// in the UI, blc still appeared as assigned to charger5 so I didn't change that, since that was correct

[lp-4  ] INFO 2024/05/10 11:33:39 vehicle updated: blc -> unknown
[ocpp  ] TRACE 2024/05/10 11:33:43 received JSON message from charger2: [2,"337299670","MeterValues",{"meterValue": [{"timestamp": "2024-05-10T09:33:43Z","sampledValue": [{"format": "Raw","location": "Outlet","context": "Sample.Periodic","measurand": "Energy.Active.Import.Register","unit": "Wh","value": "3997720.5"} ]} ],"connectorId": 1,"transactionId": 2}]
[ocpp  ] TRACE 2024/05/10 11:33:43 sent JSON message to charger2: [3,"337299670",{}]
[ocpp  ] TRACE 2024/05/10 11:33:50 received JSON message from charger5: [2,"1598022262","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:33:50 sent JSON message to charger5: [3,"1598022262",{"currentTime":"2024-05-10T09:33:50Z"}]
[ocpp  ] TRACE 2024/05/10 11:33:53 received JSON message from charger3: [2,"1696989972","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:33:53 sent JSON message to charger3: [3,"1696989972",{"currentTime":"2024-05-10T09:33:53Z"}]
[lp-1  ] DEBUG 2024/05/10 11:34:00 set max current: 7
[lp-2  ] DEBUG 2024/05/10 11:34:00 set max current: 26
[site  ] DEBUG 2024/05/10 11:34:01 ----
[lp-1  ] DEBUG 2024/05/10 11:34:01 charge power: 3910W
[lp-2  ] DEBUG 2024/05/10 11:34:01 charge power: 3910W
[lp-3  ] DEBUG 2024/05/10 11:34:01 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:34:01 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:34:01 charge power: 0W
[lp-6  ] DEBUG 2024/05/10 11:34:01 charge power: 0W
[site  ] DEBUG 2024/05/10 11:34:01 grid meter: 16985W
[site  ] DEBUG 2024/05/10 11:34:01 grid currents: [33.7 17.6 19.6]A
[site  ] DEBUG 2024/05/10 11:34:01 pv power: 0W
[site  ] DEBUG 2024/05/10 11:34:01 site power: 16985W
[lp-5  ] DEBUG 2024/05/10 11:34:01 vehicle odometer: 20358km
[lp-5  ] DEBUG 2024/05/10 11:34:01 charger status: C
[lp-5  ] INFO 2024/05/10 11:34:01 car connected
[lp-5  ] DEBUG 2024/05/10 11:34:01 vehicle api refresh
[lp-5  ] DEBUG 2024/05/10 11:34:01 pv timer elapse
[lp-5  ] DEBUG 2024/05/10 11:34:01 pv timer inactive
[lp-5  ] INFO 2024/05/10 11:34:01 start charging ->
[lp-5  ] DEBUG 2024/05/10 11:34:01 wake-up timer: stop
[lp-5  ] DEBUG 2024/05/10 11:34:01 vehicle soc: 87%
[lp-5  ] DEBUG 2024/05/10 11:34:01 vehicle range: 298km
[lp-5  ] WARN 2024/05/10 11:34:01 charger logic error: disabled but charging
[lp-5  ] DEBUG 2024/05/10 11:34:01 charger enable
[ocpp  ] TRACE 2024/05/10 11:34:01 sent JSON message to charger5: [2,"2504541038","SetChargingProfile",{"connectorId":1,"csChargingProfiles":{"chargingProfileId":1,"transactionId":1,"stackLevel":0,"chargingProfilePurpose":"TxProfile","chargingProfileKind":"Relative","chargingSchedule":{"chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":32}]}}}]
[ocpp  ] TRACE 2024/05/10 11:34:02 received JSON message from charger5: [3,"2504541038",{"status": "Accepted"}]
[lp-5  ] DEBUG 2024/05/10 11:34:02 max charge current: 32A
[ocpp  ] TRACE 2024/05/10 11:34:06 received JSON message from charger1: [2,"1379493735","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:34:06 sent JSON message to charger1: [3,"1379493735",{"currentTime":"2024-05-10T09:34:06Z"}]
[ocpp  ] TRACE 2024/05/10 11:34:12 received JSON message from charger6: [2,"736529129","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:34:12 sent JSON message to charger6: [3,"736529129",{"currentTime":"2024-05-10T09:34:12Z"}]
[ocpp  ] TRACE 2024/05/10 11:34:19 received JSON message from charger4: [2,"837726995","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:34:19 sent JSON message to charger4: [3,"837726995",{"currentTime":"2024-05-10T09:34:19Z"}]
[site  ] DEBUG 2024/05/10 11:34:31 ----
[lp-1  ] DEBUG 2024/05/10 11:34:31 charge power: 3910W
[lp-2  ] DEBUG 2024/05/10 11:34:31 charge power: 3910W
[lp-3  ] DEBUG 2024/05/10 11:34:31 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:34:31 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:34:31 charge power: 7360W
[lp-6  ] DEBUG 2024/05/10 11:34:31 charge power: 0W
[site  ] DEBUG 2024/05/10 11:34:31 grid meter: 17172W
[site  ] DEBUG 2024/05/10 11:34:31 grid currents: [33.6 17.5 20.5]A
[site  ] DEBUG 2024/05/10 11:34:31 pv power: 0W
[site  ] DEBUG 2024/05/10 11:34:31 site power: 17172W
[lp-6  ] DEBUG 2024/05/10 11:34:31 charger status: A
[lp-6  ] INFO 2024/05/10 11:34:31 car disconnected
[lp-6  ] DEBUG 2024/05/10 11:34:31 set session soc limit: 0
[lp-6  ] DEBUG 2024/05/10 11:34:31 set session energy limit: 0
[ocpp  ] TRACE 2024/05/10 11:34:36 received JSON message from charger2: [2,"1384216857","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:34:36 sent JSON message to charger2: [3,"1384216857",{"currentTime":"2024-05-10T09:34:36Z"}]
[ocpp  ] TRACE 2024/05/10 11:34:41 received JSON message from charger1: [2,"1361675698","MeterValues",{"meterValue": [{"timestamp": "2024-05-10T09:34:40Z","sampledValue": [{"format": "Raw","location": "Outlet","context": "Sample.Periodic","measurand": "Energy.Active.Import.Register","unit": "Wh","value": "1781453.5"} ]} ],"connectorId": 1,"transactionId": 3}]
[ocpp  ] TRACE 2024/05/10 11:34:41 sent JSON message to charger1: [3,"1361675698",{}]
[ocpp  ] TRACE 2024/05/10 11:34:50 received JSON message from charger5: [2,"1274163004","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:34:50 sent JSON message to charger5: [3,"1274163004",{"currentTime":"2024-05-10T09:34:50Z"}]
[ocpp  ] TRACE 2024/05/10 11:34:54 received JSON message from charger3: [2,"975891066","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:34:54 sent JSON message to charger3: [3,"975891066",{"currentTime":"2024-05-10T09:34:54Z"}]
[site  ] DEBUG 2024/05/10 11:35:01 ----
[lp-1  ] DEBUG 2024/05/10 11:35:01 charge power: 3910W
[lp-2  ] DEBUG 2024/05/10 11:35:01 charge power: 3910W
[lp-3  ] DEBUG 2024/05/10 11:35:01 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:35:01 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:35:01 charge power: 7360W
[lp-6  ] DEBUG 2024/05/10 11:35:01 charge power: 0W
[site  ] DEBUG 2024/05/10 11:35:01 grid meter: 17396W
[site  ] DEBUG 2024/05/10 11:35:01 grid currents: [33.5 17.5 21.6]A
[site  ] DEBUG 2024/05/10 11:35:01 pv power: 0W
[site  ] DEBUG 2024/05/10 11:35:01 site power: 17396W
[lp-1  ] DEBUG 2024/05/10 11:35:01 charger status: C
[ocpp  ] TRACE 2024/05/10 11:35:01 sent JSON message to charger1: [2,"1211089708","SetChargingProfile",{"connectorId":1,"csChargingProfiles":{"chargingProfileId":1,"transactionId":3,"stackLevel":0,"chargingProfilePurpose":"TxProfile","chargingProfileKind":"Relative","chargingSchedule":{"chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":7}]}}}]
[ocpp  ] TRACE 2024/05/10 11:35:02 received JSON message from charger1: [3,"1211089708",{"status": "Accepted"}]
[lp-1  ] DEBUG 2024/05/10 11:35:02 max charge current: 7A
[ocpp  ] TRACE 2024/05/10 11:35:06 received JSON message from charger1: [2,"278220403","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:35:06 sent JSON message to charger1: [3,"278220403",{"currentTime":"2024-05-10T09:35:06Z"}]
[ocpp  ] TRACE 2024/05/10 11:35:12 received JSON message from charger6: [2,"529880554","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:35:12 sent JSON message to charger6: [3,"529880554",{"currentTime":"2024-05-10T09:35:12Z"}]
[ocpp  ] TRACE 2024/05/10 11:35:20 received JSON message from charger4: [2,"82991730","Heartbeat",{}]
[ocpp  ] TRACE 2024/05/10 11:35:20 sent JSON message to charger4: [3,"82991730",{"currentTime":"2024-05-10T09:35:20Z"}]
[ocpp  ] TRACE 2024/05/10 11:35:28 received JSON message from charger3: [2,"295268630","MeterValues",{"meterValue": [{"timestamp": "2024-05-10T09:35:27Z","sampledValue": [{"format": "Raw","location": "Outlet","context": "Sample.Periodic","measurand": "Energy.Active.Import.Register","unit": "Wh","value": "3828525.1"} ]} ],"connectorId": 1,"transactionId": 1}]
[ocpp  ] TRACE 2024/05/10 11:35:28 sent JSON message to charger3: [3,"295268630",{}]
[site  ] DEBUG 2024/05/10 11:35:31 ----
[lp-1  ] DEBUG 2024/05/10 11:35:31 charge power: 1610W
[lp-2  ] DEBUG 2024/05/10 11:35:31 charge power: 3910W
[lp-3  ] DEBUG 2024/05/10 11:35:31 charge power: 0W
[lp-4  ] DEBUG 2024/05/10 11:35:31 charge power: 0W
[lp-5  ] DEBUG 2024/05/10 11:35:31 charge power: 7360W
[lp-6  ] DEBUG 2024/05/10 11:35:31 charge power: 0W
[site  ] DEBUG 2024/05/10 11:35:31 grid meter: 17077W
[site  ] DEBUG 2024/05/10 11:35:31 grid currents: [33.5 17.4 20.5]A
[site  ] DEBUG 2024/05/10 11:35:31 pv power: 0W
[site  ] DEBUG 2024/05/10 11:35:31 site power: 17077W
[lp-2  ] DEBUG 2024/05/10 11:35:31 charger status: C
[lp-2  ] DEBUG 2024/05/10 11:35:31 vehicle api refresh

// blc is once again automatically assigned to another charger, charger2, despite showing as already assigned to charger 5 in the UI - like before, it now appears as assigned to both loadpoint 2 and 5 in the UI

[main  ] DEBUG 2024/05/10 11:35:31 vehicle status: C (blc)
[main  ] DEBUG 2024/05/10 11:35:31 vehicle status: A (sfr)
[lp-2  ] INFO 2024/05/10 11:35:31 vehicle updated: unknown -> blc
[lp-2  ] DEBUG 2024/05/10 11:35:31 vehicle soc: 87%
[lp-2  ] DEBUG 2024/05/10 11:35:31 vehicle range: 298km

What type of operating system are you running?

Docker container

Version

evcc version 0.126.2
@andig
Copy link
Member

andig commented May 11, 2024

Again, it appeared as assigned to two chargers in the UI.

That would be a bug, but unfortunately it's not visible from the logfile.

@andig andig added the question Rather clarification than issue label May 11, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
question Rather clarification than issue
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@andig @jduar