evcc icon indicating copy to clipboard operation
evcc copied to clipboard
verified publisher icon evcc-io

ABL eMH3: OCPP setup issues

Open etecprojekt opened this issue 1 year ago • 61 comments

Describe the bug

Hallo zusammen,

nach dem Update von Version 0.129.0 auf 0.130.2 funktioniert die Ansteuerung der ABL eMH3 (3W2263) nicht mehr. Nachfolgende Fehlermeldungen aus dem Log:

[ocpp ] ERROR 2024/08/21 07:04:20 ocpp message (2383823729): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "2383823729" ,{"status":"Accepted","connectorId":1,"scheduleStart":"2024-08-21T05:04:19.385+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T05:04:19.385+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":-1.0}]}}]) Die Ladung wird laut Log wohl freigegeben aber es erfolgt keine Ladung. Haben jetzt erstmal wieder auf Version 0.129.0 zurück.

Steps to reproduce

PV-Überschussladen, Min+PV ohne Funktion.

Configuration details

# open evcc at http://evcc.local:7070
network:
  schema: http
  host: evcc.local # .local suffix announces the hostname on MDNS
  port: 7070

log: debug
levels:
  cache: error
  ocpp: trace

# https://docs.evcc.io/docs/reference/configuration/log/

# unique installation id
plant: 

interval: 30s # control cycle interval

sponsortoken: 

# sponsors can set telemetry: true to enable anonymous data aggregation
# see https://github.com/evcc-io/evcc/discussions/4554
telemetry: false

meters:
- type: template
  template: sma-data-manager 
  id: 2  
  host: 192.168.10.194  
  port: 502  
  usage: grid  
  modbus: tcpip  
  name: grid1

- type: template
  template: sma-data-manager 
  id: 2  
  host: 192.168.10.194  
  port: 502  
  usage: pv  
  modbus: tcpip  
  name: pv1

#- type: template
#  name: wallboxen
#  template: sma-energy-meter
#  usage: charge
#  host: 192.168.10.125

chargers:
- type: template
  template: abl
  id: 1 
  host: 192.168.21.90
  port: 502  
  modbus: rs485tcpip  
  timeout: 10s  
  name: wb_li_1

- type: template
  template: abl 
  id: 2
  host: 192.168.21.90
  port: 502  
  modbus: rs485tcpip  
  timeout: 10s
  name: wb_li_2

- type: template
  template: ocpp
  stationid: ABL_3W226305065
  connector: 1
  connecttimeout: 5m
  timeout: 5m
  getconfiguration: true
  bootnotification: true
  chargingrateunit: W
  idtag: 10101010101010
  name: wb_re_1

- type: template
  template: ocpp
  stationid: ABL_3W226305065
  connector: 2
  connecttimeout: 5m
  timeout: 5m
  getconfiguration: true
  bootnotification: true
  chargingrateunit: W
  idtag: 10101010101010
  name: wb_re_2

loadpoints:
- title: Wallbox links (links)
  charger: wb_li_1
  mode: pv
  circuit: wallboxen
  priority: 1

- title: Wallbox links (rechts)
  charger: wb_li_2
  mode: pv
  circuit: wallboxen
  priority: 4

- title: Wallbox rechts (links)
  charger: wb_re_1
  mode: pv
  circuit: wallboxen
  priority: 2

- title: Wallbox rechts (rechts)
  charger: wb_re_2
  mode: pv
  circuit: wallboxen
  priority: 3

#  enable:
#      delay: 1m
#      threshold: -200 # es wird eingeschaltet, wenn 1 Minute lang 200 W Einspeisung vorhanden sind
#    disable:
#      delay: 30m
#      threshold: 1200 # es wird ausgeschaltet, wenn 30 Minuten lang mehr als 1200 W Netzstrom bezogen wurde

vehicles:
- name: XXXX
  type: mercedes
  title: XXXX
  user: XXXX
  region: EMEA
  vin: XXXX
  capacity: 31
  tokens:
    access: 
    refresh: 

- name: XXXX
  type: mercedes
  title: XXXX
  user: XXXX
  region: EMEA
  vin: XXXX
  capacity: 31
  tokens:
    access: 
    refresh: 

- name: XXXXX
  type: mercedes
  title: XXXX
  user: XXXX
  region: EMEA
  vin: XXXX
  capacity: 15.6
  tokens:
    access: 
    refresh: 

- name: GTE_XXXX
  type: template
  template: offline
  title: XXXXX
  capacity: 8.7

tariffs:
  currency: EUR # (default EUR)
  grid:
    type: fixed
    price: 0.32 # [currency]/kWh

  feedin:
    type: fixed
    price: 0.09 # [currency]/kWh

circuits:
- name: main
  maxCurrent: 0
  maxPower: 43647
  meter: grid1

- name: wallboxen
  maxCurrent: 0
  maxPower: 22000
  meter: 
  parent: main

site:
  title: XXXXX
  meters:
    grid: grid1
    pv:
    - pv1
  circuit: main

Log details

[lp-4  ] ERROR 2024/08/21 08:50:10 charge voltages: not available
[lp-4  ] ERROR 2024/08/21 08:50:10 charge total import: not available
[lp-4  ] DEBUG 2024/08/21 08:50:10 charger status: A
[ocpp  ] TRACE 2024/08/21 08:50:10 send ABL_3W226305065: [2,"1907607332","GetCompositeSchedule",{"connectorId":2,"duration":60}]
[ocpp  ] TRACE 2024/08/21 08:50:10 recv ABL_3W226305065: [3, "1907607332" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:50:09.336+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:50:09.336+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}]
[ocpp  ] ERROR 2024/08/21 08:50:10 ocpp message (1907607332): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "1907607332" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:50:09.336+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:50:09.336+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}])
[abl   ] TRACE 2024/08/21 08:51:10 modbus: closing connection due to idle timeout: 1m0.0050541s
[modbus] TRACE 2024/08/21 08:51:10 modbus: closing connection due to idle timeout: 1m0.000633606s
[circuit-wallboxen] TRACE 2024/08/21 08:51:10 validate power: 3496W + (0W -> 0W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:51:10 validate power: -1071W + (0W -> 0W) <= 43647W ok
[site  ] DEBUG 2024/08/21 08:51:10 ----
[abl   ] TRACE 2024/08/21 08:51:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[abl   ] TRACE 2024/08/21 08:51:10 modbus: send ":0103002E0005C9\r\n"
[ocpp  ] TRACE 2024/08/21 08:51:10 recv ABL_3W226305065: [2, "21867854", "Heartbeat" ,{}]
[ocpp  ] TRACE 2024/08/21 08:51:10 send ABL_3W226305065: [3,"21867854",{"currentTime":"2024-08-21T06:51:10Z"}]
[abl   ] TRACE 2024/08/21 08:51:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[lp-1  ] DEBUG 2024/08/21 08:51:10 charge power: 3473W
[abl   ] TRACE 2024/08/21 08:51:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[abl   ] TRACE 2024/08/21 08:51:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[lp-1  ] DEBUG 2024/08/21 08:51:11 charge currents: [15.1 0 0]A
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:51:11 charge power: 0W
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:51:11 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:51:11 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:51:11 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:51:11 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:51:11 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:51:11 power: 3473W
[circuit-wallboxen] DEBUG 2024/08/21 08:51:11 current: 15.1A
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8c 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8c 00 00 00 07 02 03 04 00 00 05 b4
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8c 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8c 00 00 00 07 02 03 04 00 00 11 fa
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8c 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8c 00 00 00 07 02 03 04 ff ff e6 26
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8c 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8c 00 00 00 07 02 03 04 00 00 21 1f
[circuit-main] DEBUG 2024/08/21 08:51:11 power: -1460W
[circuit-main] DEBUG 2024/08/21 08:51:11 current: 6.62A
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 03 48 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 03 48 00 00 00 07 02 03 04 00 00 1c 6b
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 03 48 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 03 48 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:51:11 pv power: 7275W
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8d 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8d 00 00 00 07 02 03 04 00 00 05 b4
[site  ] DEBUG 2024/08/21 08:51:11 grid meter: -1460W
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8d 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8d 00 00 00 07 02 03 04 00 00 11 fa
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8d 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8d 00 00 00 07 02 03 04 ff ff e6 26
[modbus] TRACE 2024/08/21 08:51:11 modbus: send 06 8d 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:51:11 modbus: recv 06 8d 00 00 00 07 02 03 04 00 00 21 1f
[site  ] DEBUG 2024/08/21 08:51:11 grid currents: [-4.6 6.62 -8.48]A
[site  ] DEBUG 2024/08/21 08:51:11 site power: -1460W
[lp-1  ] DEBUG 2024/08/21 08:51:11 detected active phases: 1p
[lp-1  ] DEBUG 2024/08/21 08:51:11 !! session: chargeRater.chargedEnergy=1.7 - chargedAtStartup=0.0
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":010300040001F7\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">01030204C234\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":010300040001F7\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">01030204C234\r\n"
[lp-1  ] DEBUG 2024/08/21 08:51:11 charger status: C
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":0103000F0005E8\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">01030A0F3F02150215010A010A60\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: send ":0103000F0005E8\r\n"
[abl   ] TRACE 2024/08/21 08:51:11 modbus: recv ">01030A0F3F02150215010A010A60\r\n"
[lp-1  ] DEBUG 2024/08/21 08:51:11 pv charge current: 22.3A = 16A + 6.35A (-1460W @ 1p)
[circuit-wallboxen] TRACE 2024/08/21 08:51:11 validate power: 3473W + (3473W -> 3680W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:51:11 validate power: -1460W + (3473W -> 3680W) <= 43647W ok
[site  ] DEBUG 2024/08/21 08:51:39 ----
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:51:39 charge power: 3496W
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:51:39 charge currents: [15.2 0 0]A
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:51:39 charge power: 0W
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:51:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:51:40 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:51:40 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:51:40 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:51:40 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:51:40 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:51:40 power: 3496W
[circuit-wallboxen] DEBUG 2024/08/21 08:51:40 current: 15.2A
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8e 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8e 00 00 00 07 02 03 04 00 00 06 15
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8e 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8e 00 00 00 07 02 03 04 00 00 12 b8
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8e 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8e 00 00 00 07 02 03 04 ff ff e6 4a
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8e 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8e 00 00 00 07 02 03 04 00 00 21 b1
[circuit-main] DEBUG 2024/08/21 08:51:40 power: -1557W
[circuit-main] DEBUG 2024/08/21 08:51:40 current: 6.58A
[main  ] DEBUG 2024/08/21 08:51:40 lp Wallbox links (rechts) at prio 4 gets additional 3496W from Wallbox links (links) at prio 1, total 3496W
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 03 49 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 03 49 00 00 00 07 02 03 04 00 00 1c 91
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 03 49 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 03 49 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:51:40 pv power: 7313W
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8f 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8f 00 00 00 07 02 03 04 00 00 06 15
[site  ] DEBUG 2024/08/21 08:51:40 grid meter: -1557W
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8f 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8f 00 00 00 07 02 03 04 00 00 12 b8
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8f 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8f 00 00 00 07 02 03 04 ff ff e6 4a
[modbus] TRACE 2024/08/21 08:51:40 modbus: send 06 8f 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:51:40 modbus: recv 06 8f 00 00 00 07 02 03 04 00 00 21 b1
[site  ] DEBUG 2024/08/21 08:51:40 grid currents: [-4.79 6.58 -8.62]A
[site  ] DEBUG 2024/08/21 08:51:40 giving loadpoint priority for additional: 3496W
[site  ] DEBUG 2024/08/21 08:51:40 site power: -5053W
[abl   ] TRACE 2024/08/21 08:51:40 modbus: send ":020300040001F6\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: recv ">02030204A154\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: send ":020300040001F6\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: recv ">02030204A154\r\n"
[lp-2  ] DEBUG 2024/08/21 08:51:40 charger status: A
[abl   ] TRACE 2024/08/21 08:51:40 modbus: send ":0203000F0005E7\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: recv ">02030A0F3F0215021503E8014D3C\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: send ":0203000F0005E7\r\n"
[abl   ] TRACE 2024/08/21 08:51:40 modbus: recv ">02030A0F3F0215021503E8014D3C\r\n"
[circuit-wallboxen] TRACE 2024/08/21 08:51:40 validate power: 3496W + (0W -> 0W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:51:40 validate power: -1557W + (0W -> 0W) <= 43647W ok
[site  ] DEBUG 2024/08/21 08:52:09 ----
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:52:09 charge power: 3496W
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:52:09 charge currents: [15.2 0 0]A
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:52:09 charge power: 0W
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:52:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:52:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:52:10 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:52:10 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:52:10 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:52:10 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:52:10 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:52:10 power: 3496W
[circuit-wallboxen] DEBUG 2024/08/21 08:52:10 current: 15.2A
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 90 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 90 00 00 00 07 02 03 04 00 00 06 66
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 90 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 90 00 00 00 07 02 03 04 00 00 13 37
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 90 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 90 00 00 00 07 02 03 04 ff ff e6 91
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 90 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 90 00 00 00 07 02 03 04 00 00 22 03
[circuit-main] DEBUG 2024/08/21 08:52:10 power: -1638W
[circuit-main] DEBUG 2024/08/21 08:52:10 current: 6.51A
[main  ] DEBUG 2024/08/21 08:52:10 lp Wallbox rechts (links) at prio 2 gets additional 3496W from Wallbox links (links) at prio 1, total 3496W
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 03 4a 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 03 4a 00 00 00 07 02 03 04 00 00 1c c8
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 03 4a 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 03 4a 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:52:10 pv power: 7368W
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 91 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 91 00 00 00 07 02 03 04 00 00 06 66
[site  ] DEBUG 2024/08/21 08:52:10 grid meter: -1638W
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 91 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 91 00 00 00 07 02 03 04 00 00 13 37
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 91 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 91 00 00 00 07 02 03 04 ff ff e6 91
[modbus] TRACE 2024/08/21 08:52:10 modbus: send 06 91 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:52:10 modbus: recv 06 91 00 00 00 07 02 03 04 00 00 22 03
[site  ] DEBUG 2024/08/21 08:52:10 grid currents: [-4.92 6.51 -8.71]A
[site  ] DEBUG 2024/08/21 08:52:10 giving loadpoint priority for additional: 3496W
[site  ] DEBUG 2024/08/21 08:52:10 site power: -5134W
[lp-3  ] ERROR 2024/08/21 08:52:10 charge voltages: not available
[lp-3  ] ERROR 2024/08/21 08:52:10 charge total import: not available
[ABL_3W226305065-1] WARN 2024/08/21 08:52:10 waiting for local authentication
[lp-3  ] DEBUG 2024/08/21 08:52:10 charger status: B
[ocpp  ] TRACE 2024/08/21 08:52:10 send ABL_3W226305065: [2,"2736819474","GetCompositeSchedule",{"connectorId":1,"duration":60}]
[ocpp  ] TRACE 2024/08/21 08:52:10 recv ABL_3W226305065: [3, "2736819474" ,{"status":"Accepted","connectorId":1,"scheduleStart":"2024-08-21T06:52:08.655+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:52:08.655+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":6.5}]}}]
[ocpp  ] ERROR 2024/08/21 08:52:10 ocpp message (2736819474): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "2736819474" ,{"status":"Accepted","connectorId":1,"scheduleStart":"2024-08-21T06:52:08.655+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:52:08.655+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":6.5}]}}])
[abl   ] TRACE 2024/08/21 08:53:09 modbus: closing connection due to idle timeout: 1m0.000446445s
[modbus] TRACE 2024/08/21 08:53:10 modbus: closing connection due to idle timeout: 1m0.00095009s
[lp-3  ] DEBUG 2024/08/21 08:53:10 pv charge current: 7.44A = 0A + 7.44A (-5134W @ 3p)
[circuit-wallboxen] TRACE 2024/08/21 08:53:10 validate power: 3496W + (0W -> 5134W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:53:10 validate power: -1638W + (0W -> 5134W) <= 43647W ok
[ocpp  ] TRACE 2024/08/21 08:53:10 send ABL_3W226305065: [2,"524367911","SetChargingProfile",{"connectorId":1,"csChargingProfiles":{"chargingProfileId":0,"stackLevel":0,"chargingProfilePurpose":"TxDefaultProfile","chargingProfileKind":"Absolute","chargingSchedule":{"startSchedule":"2024-08-21T06:53:10Z","chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":7.4}]}}}]
[ocpp  ] TRACE 2024/08/21 08:53:10 recv ABL_3W226305065: [3, "524367911" ,{"status":"Accepted"}]
[lp-3  ] DEBUG 2024/08/21 08:53:10 max charge current: 7.44A
[site  ] DEBUG 2024/08/21 08:53:10 ----
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:53:10 charge power: 3496W
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:53:10 charge currents: [15.2 0 0]A
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:53:10 charge power: 0W
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:53:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:53:10 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:53:10 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:53:10 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:53:10 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:53:10 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:53:10 power: 3496W
[circuit-wallboxen] DEBUG 2024/08/21 08:53:10 current: 15.2A
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 92 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 92 00 00 00 07 02 03 04 00 00 06 98
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 92 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 92 00 00 00 07 02 03 04 00 00 13 b2
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 92 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 92 00 00 00 07 02 03 04 ff ff e6 b9
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 92 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 92 00 00 00 07 02 03 04 00 00 22 06
[circuit-main] DEBUG 2024/08/21 08:53:10 power: -1688W
[circuit-main] DEBUG 2024/08/21 08:53:10 current: 6.47A
[main  ] DEBUG 2024/08/21 08:53:10 lp Wallbox rechts (rechts) at prio 3 gets additional 3496W from Wallbox links (links) at prio 1, total 3496W
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 03 4b 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 03 4b 00 00 00 07 02 03 04 00 00 1c e5
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 03 4b 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 03 4b 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:53:10 pv power: 7397W
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 93 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 93 00 00 00 07 02 03 04 00 00 06 98
[site  ] DEBUG 2024/08/21 08:53:10 grid meter: -1688W
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 93 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 93 00 00 00 07 02 03 04 00 00 13 b2
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 93 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 93 00 00 00 07 02 03 04 ff ff e6 b9
[modbus] TRACE 2024/08/21 08:53:10 modbus: send 06 93 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:53:10 modbus: recv 06 93 00 00 00 07 02 03 04 00 00 22 06
[site  ] DEBUG 2024/08/21 08:53:10 grid currents: [-5.04 6.47 -8.71]A
[site  ] DEBUG 2024/08/21 08:53:10 giving loadpoint priority for additional: 3496W
[site  ] DEBUG 2024/08/21 08:53:10 site power: -5184W
[lp-4  ] ERROR 2024/08/21 08:53:10 charge voltages: not available
[lp-4  ] ERROR 2024/08/21 08:53:10 charge total import: not available
[lp-4  ] DEBUG 2024/08/21 08:53:10 charger status: A
[ocpp  ] TRACE 2024/08/21 08:53:10 send ABL_3W226305065: [2,"2360772600","GetCompositeSchedule",{"connectorId":2,"duration":60}]
[ocpp  ] TRACE 2024/08/21 08:53:10 recv ABL_3W226305065: [3, "2360772600" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:53:09.343+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:53:09.343+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}]
[ocpp  ] ERROR 2024/08/21 08:53:10 ocpp message (2360772600): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "2360772600" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:53:09.343+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:53:09.343+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}])
[abl   ] TRACE 2024/08/21 08:54:10 modbus: closing connection due to idle timeout: 1m0.000963872s
[modbus] TRACE 2024/08/21 08:54:10 modbus: closing connection due to idle timeout: 1m0.000412423s
[circuit-wallboxen] TRACE 2024/08/21 08:54:10 validate power: 3496W + (0W -> 0W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:54:10 validate power: -1688W + (0W -> 0W) <= 43647W ok
[site  ] DEBUG 2024/08/21 08:54:10 ----
[abl   ] TRACE 2024/08/21 08:54:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:54:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:54:10 charge power: 3496W
[abl   ] TRACE 2024/08/21 08:54:10 modbus: send ":0103002E0005C9\r\n"
[ocpp  ] TRACE 2024/08/21 08:54:10 recv ABL_3W226305065: [2, "4332465", "Heartbeat" ,{}]
[ocpp  ] TRACE 2024/08/21 08:54:10 send ABL_3W226305065: [3,"4332465",{"currentTime":"2024-08-21T06:54:10Z"}]
[abl   ] TRACE 2024/08/21 08:54:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:54:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:10 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:54:10 charge currents: [15.2 0 0]A
[abl   ] TRACE 2024/08/21 08:54:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:54:11 charge power: 0W
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:54:11 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:54:11 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:54:11 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:54:11 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:54:11 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:54:11 power: 3496W
[circuit-wallboxen] DEBUG 2024/08/21 08:54:11 current: 15.2A
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 94 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 94 00 00 00 07 02 03 04 00 00 07 0b
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 94 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 94 00 00 00 07 02 03 04 00 00 14 3c
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 94 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 94 00 00 00 07 02 03 04 ff ff e7 2c
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 94 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 94 00 00 00 07 02 03 04 00 00 22 bd
[circuit-main] DEBUG 2024/08/21 08:54:11 power: -1803W
[circuit-main] DEBUG 2024/08/21 08:54:11 current: 6.36A
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 03 4c 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 03 4c 00 00 00 07 02 03 04 00 00 1d 73
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 03 4c 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 03 4c 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:54:11 pv power: 7539W
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 95 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 95 00 00 00 07 02 03 04 00 00 07 0b
[site  ] DEBUG 2024/08/21 08:54:11 grid meter: -1803W
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 95 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 95 00 00 00 07 02 03 04 00 00 14 3c
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 95 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 95 00 00 00 07 02 03 04 ff ff e7 2c
[modbus] TRACE 2024/08/21 08:54:11 modbus: send 06 95 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:54:11 modbus: recv 06 95 00 00 00 07 02 03 04 00 00 22 bd
[site  ] DEBUG 2024/08/21 08:54:11 grid currents: [-5.18 6.36 -8.89]A
[site  ] DEBUG 2024/08/21 08:54:11 site power: -1803W
[lp-1  ] DEBUG 2024/08/21 08:54:11 detected active phases: 1p
[lp-1  ] DEBUG 2024/08/21 08:54:11 !! session: chargeRater.chargedEnergy=1.9 - chargedAtStartup=0.0
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":010300040001F7\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">01030204C234\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":010300040001F7\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">01030204C234\r\n"
[lp-1  ] DEBUG 2024/08/21 08:54:11 charger status: C
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":0103000F0005E8\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">01030A0F3F02150215010A010A60\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: send ":0103000F0005E8\r\n"
[abl   ] TRACE 2024/08/21 08:54:11 modbus: recv ">01030A0F3F02150215010A010A60\r\n"
[lp-1  ] DEBUG 2024/08/21 08:54:11 pv charge current: 23.8A = 16A + 7.84A (-1803W @ 1p)
[circuit-wallboxen] TRACE 2024/08/21 08:54:11 validate power: 3496W + (3496W -> 3680W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:54:11 validate power: -1803W + (3496W -> 3680W) <= 43647W ok
[site  ] DEBUG 2024/08/21 08:54:39 ----
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:54:39 charge power: 3496W
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">01030A2EC2910A000100010098CD\r\n"
[lp-1  ] DEBUG 2024/08/21 08:54:39 charge currents: [15.2 0 0]A
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:54:39 charge power: 0W
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:54:39 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:54:39 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:54:39 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:54:39 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:54:39 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:54:39 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:54:39 power: 3496W
[circuit-wallboxen] DEBUG 2024/08/21 08:54:39 current: 15.2A
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 96 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 96 00 00 00 07 02 03 04 00 00 07 29
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 96 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 96 00 00 00 07 02 03 04 00 00 14 60
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 96 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 96 00 00 00 07 02 03 04 ff ff e7 36
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 96 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 96 00 00 00 07 02 03 04 00 00 23 0c
[circuit-main] DEBUG 2024/08/21 08:54:39 power: -1833W
[circuit-main] DEBUG 2024/08/21 08:54:39 current: 6.35A
[main  ] DEBUG 2024/08/21 08:54:39 lp Wallbox links (rechts) at prio 4 gets additional 3496W from Wallbox links (links) at prio 1, total 3496W
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 03 4d 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 03 4d 00 00 00 07 02 03 04 00 00 1d 92
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 03 4d 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 03 4d 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:54:39 pv power: 7570W
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 97 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 97 00 00 00 07 02 03 04 00 00 07 29
[site  ] DEBUG 2024/08/21 08:54:39 grid meter: -1833W
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 97 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 97 00 00 00 07 02 03 04 00 00 14 60
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 97 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 97 00 00 00 07 02 03 04 ff ff e7 36
[modbus] TRACE 2024/08/21 08:54:39 modbus: send 06 97 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:54:39 modbus: recv 06 97 00 00 00 07 02 03 04 00 00 23 0c
[site  ] DEBUG 2024/08/21 08:54:39 grid currents: [-5.22 6.35 -8.97]A
[site  ] DEBUG 2024/08/21 08:54:39 giving loadpoint priority for additional: 3496W
[site  ] DEBUG 2024/08/21 08:54:39 site power: -5329W
[abl   ] TRACE 2024/08/21 08:54:39 modbus: send ":020300040001F6\r\n"
[abl   ] TRACE 2024/08/21 08:54:40 modbus: recv ">02030204A154\r\n"
[abl   ] TRACE 2024/08/21 08:54:40 modbus: send ":020300040001F6\r\n"
[abl   ] TRACE 2024/08/21 08:54:40 modbus: recv ">02030204A154\r\n"
[lp-2  ] DEBUG 2024/08/21 08:54:40 charger status: A
[abl   ] TRACE 2024/08/21 08:54:40 modbus: send ":0203000F0005E7\r\n"
[abl   ] TRACE 2024/08/21 08:54:40 modbus: recv ">02030A0F3F0215021503E8014D3C\r\n"
[abl   ] TRACE 2024/08/21 08:54:40 modbus: send ":0203000F0005E7\r\n"
[abl   ] TRACE 2024/08/21 08:54:40 modbus: recv ">02030A0F3F0215021503E8014D3C\r\n"
[circuit-wallboxen] TRACE 2024/08/21 08:54:40 validate power: 3496W + (0W -> 0W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:54:40 validate power: -1833W + (0W -> 0W) <= 43647W ok
[site  ] DEBUG 2024/08/21 08:55:09 ----
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">01030A2EC2910A000100010099CC\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">01030A2EC2910A000100010099CC\r\n"
[lp-1  ] DEBUG 2024/08/21 08:55:09 charge power: 3519W
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">01030A2EC2910A000100010099CC\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">01030A2EC2910A000100010099CC\r\n"
[lp-1  ] DEBUG 2024/08/21 08:55:09 charge currents: [15.3 0 0]A
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:55:09 charge power: 0W
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:55:09 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:55:09 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:55:09 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:55:09 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:55:09 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:55:09 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:55:09 power: 3519W
[circuit-wallboxen] DEBUG 2024/08/21 08:55:09 current: 15.3A
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 98 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 98 00 00 00 07 02 03 04 00 00 07 30
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 98 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 98 00 00 00 07 02 03 04 00 00 14 a2
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 98 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 98 00 00 00 07 02 03 04 ff ff e7 3e
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 98 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 98 00 00 00 07 02 03 04 00 00 22 f8
[circuit-main] DEBUG 2024/08/21 08:55:09 power: -1840W
[circuit-main] DEBUG 2024/08/21 08:55:09 current: 6.34A
[main  ] DEBUG 2024/08/21 08:55:09 lp Wallbox rechts (links) at prio 2 gets additional 3519W from Wallbox links (links) at prio 1, total 3519W
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 03 4e 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 03 4e 00 00 00 07 02 03 04 00 00 1d 9a
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 03 4e 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 03 4e 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:55:09 pv power: 7578W
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 99 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 99 00 00 00 07 02 03 04 00 00 07 30
[site  ] DEBUG 2024/08/21 08:55:09 grid meter: -1840W
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 99 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 99 00 00 00 07 02 03 04 00 00 14 a2
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 99 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 99 00 00 00 07 02 03 04 ff ff e7 3e
[modbus] TRACE 2024/08/21 08:55:09 modbus: send 06 99 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:55:09 modbus: recv 06 99 00 00 00 07 02 03 04 00 00 22 f8
[site  ] DEBUG 2024/08/21 08:55:09 grid currents: [-5.28 6.34 -8.95]A
[site  ] DEBUG 2024/08/21 08:55:09 giving loadpoint priority for additional: 3519W
[site  ] DEBUG 2024/08/21 08:55:09 site power: -5359W
[lp-3  ] ERROR 2024/08/21 08:55:09 charge voltages: not available
[lp-3  ] ERROR 2024/08/21 08:55:09 charge total import: not available
[ABL_3W226305065-1] WARN 2024/08/21 08:55:09 waiting for local authentication
[lp-3  ] DEBUG 2024/08/21 08:55:09 charger status: B
[ocpp  ] TRACE 2024/08/21 08:55:09 send ABL_3W226305065: [2,"3445611853","GetCompositeSchedule",{"connectorId":1,"duration":60}]
[ocpp  ] TRACE 2024/08/21 08:55:10 recv ABL_3W226305065: [3, "3445611853" ,{"status":"Accepted","connectorId":1,"scheduleStart":"2024-08-21T06:55:08.665+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:55:08.665+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":7.400000095367432}]}}]
[ocpp  ] ERROR 2024/08/21 08:55:10 ocpp message (3445611853): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "3445611853" ,{"status":"Accepted","connectorId":1,"scheduleStart":"2024-08-21T06:55:08.665+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:55:08.665+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":7.400000095367432}]}}])
[abl   ] TRACE 2024/08/21 08:56:09 modbus: closing connection due to idle timeout: 1m0.003736387s
[modbus] TRACE 2024/08/21 08:56:09 modbus: closing connection due to idle timeout: 1m0.000246777s
[lp-3  ] DEBUG 2024/08/21 08:56:09 pv charge current: 7.77A = 0A + 7.77A (-5359W @ 3p)
[circuit-wallboxen] TRACE 2024/08/21 08:56:09 validate power: 3519W + (0W -> 5359W) <= 22000W ok
[circuit-main] TRACE 2024/08/21 08:56:09 validate power: -1840W + (0W -> 5359W) <= 43647W ok
[ocpp  ] TRACE 2024/08/21 08:56:09 send ABL_3W226305065: [2,"2023464164","SetChargingProfile",{"connectorId":1,"csChargingProfiles":{"chargingProfileId":0,"stackLevel":0,"chargingProfilePurpose":"TxDefaultProfile","chargingProfileKind":"Absolute","chargingSchedule":{"startSchedule":"2024-08-21T06:56:09Z","chargingRateUnit":"A","chargingSchedulePeriod":[{"startPeriod":0,"limit":7.7}]}}}]
[ocpp  ] TRACE 2024/08/21 08:56:10 recv ABL_3W226305065: [3, "2023464164" ,{"status":"Accepted"}]
[lp-3  ] DEBUG 2024/08/21 08:56:10 max charge current: 7.77A
[site  ] DEBUG 2024/08/21 08:56:10 ----
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[lp-1  ] DEBUG 2024/08/21 08:56:10 charge power: 3473W
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0103002E0005C9\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">01030A2EC2910A000100010097CE\r\n"
[lp-1  ] DEBUG 2024/08/21 08:56:10 charge currents: [15.1 0 0]A
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:56:10 charge power: 0W
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: send ":0203002E0005C8\r\n"
[abl   ] TRACE 2024/08/21 08:56:10 modbus: recv ">02030A2EA1114D03E803E803E803\r\n"
[lp-2  ] DEBUG 2024/08/21 08:56:10 charge currents: [0 0 0]A
[lp-3  ] DEBUG 2024/08/21 08:56:10 charge power: 0W
[lp-3  ] DEBUG 2024/08/21 08:56:10 charge currents: [0 0 0]A
[lp-4  ] DEBUG 2024/08/21 08:56:10 charge power: 0W
[lp-4  ] DEBUG 2024/08/21 08:56:10 charge currents: [0 0 0]A
[circuit-wallboxen] DEBUG 2024/08/21 08:56:10 power: 3473W
[circuit-wallboxen] DEBUG 2024/08/21 08:56:10 current: 15.1A
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9a 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9a 00 00 00 07 02 03 04 00 00 07 57
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9a 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9a 00 00 00 07 02 03 04 00 00 14 3d
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9a 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9a 00 00 00 07 02 03 04 ff ff e7 f6
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9a 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9a 00 00 00 07 02 03 04 00 00 23 46
[circuit-main] DEBUG 2024/08/21 08:56:10 power: -1879W
[circuit-main] DEBUG 2024/08/21 08:56:10 current: 6.15A
[main  ] DEBUG 2024/08/21 08:56:10 lp Wallbox rechts (rechts) at prio 3 gets additional 3473W from Wallbox links (links) at prio 1, total 3473W
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 03 4f 00 00 00 06 02 03 78 37 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 03 4f 00 00 00 07 02 03 04 00 00 1d c1
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 03 4f 00 00 00 06 02 03 77 31 00 04
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 03 4f 00 00 00 0b 02 03 08 ff ff ff ff ff ff ff ff
[site  ] DEBUG 2024/08/21 08:56:10 pv power: 7617W
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9b 00 00 00 06 02 03 7a 11 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9b 00 00 00 07 02 03 04 00 00 07 57
[site  ] DEBUG 2024/08/21 08:56:10 grid meter: -1879W
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9b 00 00 00 06 02 03 7b 2f 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9b 00 00 00 07 02 03 04 00 00 14 3d
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9b 00 00 00 06 02 03 7b 31 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9b 00 00 00 07 02 03 04 ff ff e7 f6
[modbus] TRACE 2024/08/21 08:56:10 modbus: send 06 9b 00 00 00 06 02 03 7b 33 00 02
[modbus] TRACE 2024/08/21 08:56:10 modbus: recv 06 9b 00 00 00 07 02 03 04 00 00 23 46
[site  ] DEBUG 2024/08/21 08:56:10 grid currents: [-5.18 6.15 -9.03]A
[site  ] DEBUG 2024/08/21 08:56:10 giving loadpoint priority for additional: 3473W
[site  ] DEBUG 2024/08/21 08:56:10 site power: -5352W
[lp-4  ] ERROR 2024/08/21 08:56:10 charge voltages: not available
[lp-4  ] ERROR 2024/08/21 08:56:10 charge total import: not available
[lp-4  ] DEBUG 2024/08/21 08:56:10 charger status: A
[ocpp  ] TRACE 2024/08/21 08:56:10 send ABL_3W226305065: [2,"140010820","GetCompositeSchedule",{"connectorId":2,"duration":60}]
[ocpp  ] TRACE 2024/08/21 08:56:10 recv ABL_3W226305065: [3, "140010820" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:56:09.340+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:56:09.340+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}]
[ocpp  ] ERROR 2024/08/21 08:56:10 ocpp message (140010820): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "140010820" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:56:09.340+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:56:09.340+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}])

What type of operating system are you running?

Linux

Version

0.130.2

etecprojekt avatar Aug 21 '24 07:08 etecprojekt

Anbei noch die volle Logdatei

[circuit-main] DEBUG 20240821 07034.txt

etecprojekt avatar Aug 21 '24 07:08 etecprojekt

[ABL_3W226305065-1] WARN 2024/08/21 08:52:10 waiting for local authentication

Die Box wartet auf die lokale Freigabe via RFID oder Free Charge-Mode.

https://github.com/evcc-io/evcc/discussions/15471

premultiply avatar Aug 21 '24 07:08 premultiply

[ocpp ] ERROR 2024/08/21 08:56:10 ocpp message (140010820): OccurrenceConstraintViolation - Field CallResult.Payload.ChargingSchedule.ChargingRateUnit required but not found for feature GetCompositeSchedule ([3, "140010820" ,{"status":"Accepted","connectorId":2,"scheduleStart":"2024-08-21T06:56:09.340+00:00","chargingSchedule":{"duration":60,"startSchedule":"2024-08-21T06:56:09.340+00:00","chargingSchedulePeriod":[{"startPeriod":0,"limit":16.0}]}}])

Das ist ein Fehler in der OCPP-Implementierung der Box. Verletzung des Standards. Bitte damit an den Hersteller wenden.

premultiply avatar Aug 21 '24 07:08 premultiply

Hallo,

vielen Dank für die Info. Da wird seitens ABL wohl nichts mehr kommen, da die eMH3 aus dem Programm genommen wurde. Also heißt das, dauerhaft die Version 0.129.0 nutzen?

Vielen Dank.

etecprojekt avatar Aug 21 '24 07:08 etecprojekt

Erstmal Problem 1 bei dir lösen, der Error ist zweitrangig und nur ein Hinweis.

premultiply avatar Aug 21 '24 07:08 premultiply

Die ID für freies Laden wird doch in der Konfiguration (idtag: 10101010101010) mit übergeben, wieso sollte die Box dann auf eine Authentifizierung waren? Es hat so bislang immer funktioniert, und es wurde nichts geändert oder neugestartet. Ich werde nochmal auf die neuste Version gehen und es nochmal beobachten.

etecprojekt avatar Aug 21 '24 07:08 etecprojekt

RFID-Karte vorhalten oder Wallbox in deren OCPP-Setup auf "Free charge", "Autostart", "Free vending" o.ä. konfigurieren. Ref https://github.com/evcc-io/evcc/pull/14888 und https://docs.evcc.io/blog/2024/08/17/highlights-14a-enwg-ocpp-loadmanagement-elli#rfid-und-autorisierung

premultiply avatar Aug 21 '24 08:08 premultiply

Nochmal kurz getestet, Konfiguration auf Freies Laden funktioniert, allerdings sind die Funktionen nicht gewünscht. Wieso wird das idTag nicht weiterhin mit übergeben? So ist eine Sperre des Ladeports möglich, wenn dieser über EVCC ausgeschaltet wird. Ist der Modus auf Freies Laden, wird erst ein Ladevorgang gestartet.

Was auch nicht geht, ist die Regelung. EVCC bekommt die Ladeleistung nicht mit, weshalb immer wieder ein und ausgeschaltet wird, obwohl diese im 10 Sekunden Takt übermittelt wird.

evcc-20240822-125117-trace.log Screenshot_1253 Screenshot_1252

etecprojekt avatar Aug 22 '24 12:08 etecprojekt

Nochmal kurz getestet, Konfiguration auf Freies Laden funktioniert,

Prima. Wie erwartet. Dann genau so lassen.

allerdings sind die Funktionen nicht gewünscht.

Die Alternative lautet RFID-Authentifizierung.

Wieso wird das idTag nicht weiterhin mit übergeben?

Das idTag heisst per default "evcc" und wird grundsätzlich nur bei RemoteStartTransaction benötigt. Nur extrem selten besteht die Notwendigkeit hierfür ein anderes, vorgegebenes manuelles idTag zu verwenden. Wird hier nicht gebraucht und daher ist diese Konfig-Option überflüssig.

So ist eine Sperre des Ladeports möglich, wenn dieser über EVCC ausgeschaltet wird.

Das ist richtig. Der Default-Modus "off" in evcc sperrt den Ladepunkt für fremde Nutzer, die Fahrzeugerkennung ermöglicht es nur berechtigte Fahrzeuge automatisch zu laden (Default-Lademodus des jeweiligen Fahrzeugs). Über die UI lassen sich auch Gastfahrzeuge freigeben.

Ist der Modus auf Freies Laden, wird erst ein Ladevorgang gestartet.

Das ist nicht richtig. Das verhindert evcc über das gesendete ChargingProfile mit Stromvorgabe 0. Es wird lediglich von der Box eine Transaktion gestartet. Ohne laufende Transaktion ist keinerlei Steuerung der Box durch evcc möglich. Die eigentliche Ladefreigabe obliegt dennnoch durch das ChargingProfile in letzter Instanz evcc. Das sind Feinheiten die man aber zum Verständnis genau differenzieren muss.

Was auch nicht geht, ist die Regelung. EVCC bekommt die Ladeleistung nicht mit, weshalb immer wieder ein und ausgeschaltet wird, obwohl diese im 10 Sekunden Takt übermittelt wird.

Das wäre ein anderes Problem was sich hoffentlich im Log erkennen lässt.

premultiply avatar Aug 22 '24 13:08 premultiply

Bitte die Konfig der beiden OCPP-Ladepunkte mal auf

- type: template
  template: ocpp
  stationid: ABL_3W226305065
  connector: 1
  name: wb_re_1
- type: template
  template: ocpp
  stationid: ABL_3W226305065
  connector: 2
  name: wb_re_2

reduzieren und den FreeCharge Mode aktivieren.

Schau auch mal bitte ob du in der Konfiguration der Box irgendwo das Meter Sample Interval Box auf 10s reduzieren kannst.

Dann mal bitte den Output von evcc charger --log trace --diagnose

premultiply avatar Aug 22 '24 14:08 premultiply

Also, ich habe jetzt dein Log mal durchgesehen.

[ocpp ] DEBUG 2024/08/22 12:30:40 charge point connected: ABL_3W226305065

Ab hier funktioniert es wie es soll. Auf Grund der Logeinträge gehe ich davon aus, dass das der Zeitpunkt war nachdem du den FreeChargeMode aktiviert hast und die Box neugestartet hat/wurde.

Bitte auch noch beachten, da du insgesamt 4 Ladepunkte hast, dass pro Intervall immer nur ein LP bearbeitet wird und es daher zu längeren Verzögerungen zwischen Aktion in der UI und tatsächlicher Änderung am Charger kommen kann. Daher ist es vielleicht hilfreich das evcc interval in der Konfig ggf. etwas zu reduzieren. Probier mal 10s ggf. auch noch weniger. Das sollte das System schon deutlich responsiver machen.

Das einzige was etwas irritierend ist, ist dass die Meteringdaten von evcc in dem Log nicht erkannt wurden und daher vermutlich keine sinnvolle Anzeige in der UI kam. Das kann aber mit der Neuverbindung durch die Änderung auf FreeChargeMode zusammenhängen. Oder auch mit dem sehr langen intervall durch die 4 LPs.

Das würde ich gerne mit einem aktuellen Log nochmal genauer ansehen.

Hier also bitte nochmal mit dem aktuellen Nightly Build testen. Dazu bitte FreeChargeMode anschalten bzw. angeschaltet lassen, dann die Box vollständig neustarten und dann erst evcc (neu)starten.

premultiply avatar Aug 22 '24 17:08 premultiply

Werde ich morgen nochmal testen. Etwas schwierig mit 1-4 Fahrzeugen und Sonne die mal da ist und mal nicht 😁 Das Blöde an Mercedes ist noch, wenn innerhalb von 30 Minute - 3 mal ausgeschaltet wird, geht das Fahrzeug auf Ladestörung.

Ich habe die Box schon mal umgestellt und auf nightly geswitcht. Interval habe ich auf 10s gestellt, mir war nicht bewusst, dass immer nur eine in einem Durchlauf bearbeitet wird.

Lokale Vorauthorisierung habe ich auch mal ausgeschaltet. image

Nachfolgend noch ein Log, nach dem EVCC start, ohne Fahrzeuge. evcc-20240822-211328-trace.log

etecprojekt avatar Aug 22 '24 19:08 etecprojekt

Fahrzeug wurde angesteckt, erst mit 6A geladen, dann mit 16A und dann gestoppt, obwohl kein Überschuss verfügbar war, idTag ist in der Config nicht mehr drin.

Trace: evcc-20240823-065208-trace.log W Wallbox: Screenshot_1254

Screenshot_1253

Screenshot_1255

Screenshot_1256

etecprojekt avatar Aug 23 '24 04:08 etecprojekt

Eine manuelle Ansteuerung über Min+PV funktioniert, Zählerwerte werden gesendet, allerdings wird die Ladeleistung in EVCC nicht erkannt, somit wird die Überschussregelung nicht funktionieren, da so kein Überschuss erkennen wird.

evcc-20240823-080348-trace.log

etecprojekt avatar Aug 23 '24 06:08 etecprojekt

Die Anzeige der Leistung des Ladepunkts hat nicht mit der Überschussregelung zu tun. Diese basiert ausschließlich auf den Daten des Netzanschlusses (grid).

premultiply avatar Aug 23 '24 07:08 premultiply

Abgesehen von den diversen Fehlermeldungen auf Grund von Fehlern in der Firmware funktioniert es nach dem erstem Blick in das Log aber nun eigentlich wie es soll.

Bei der Ausgabe der nicht kritischen Fehler werden wir sicherlich noch nachjustieren.

Die Sache mit den Meteringdaten stellt mich aber gerade noch vor ein Rätsel.

/cc @andig Ich stehe auf dem Schlauch. Weshalb werden hier die Ladeleistungen und Energie mit NotAvailable abgelehnt? Hast du eine Idee?

Und wir haben mit Blick auf den Screenshot offensichtlich das Problem, dass wir die interne Constraint-Fehlerausgabe via OCPP an den Charger zurückwerfen, was dieser sicherlich nicht verstehen wird.

premultiply avatar Aug 23 '24 07:08 premultiply

Ich glaube du hast recht, er merkt also das die Box Strom zieht (Leistung fehlt), zeigt es glaube ich nur nicht an. Würde er es nicht merken, würde er ja immer wieder an und ausschalten, da er nicht weiß, wieviel Anteil Ladeleistung in Grid steckt. Anbei ein Log mit einem Fahrzeug dran, welches 1p läd und geregelt wird.

[lp-3 ] ERROR 2024/08/23 10:59:22 charge power: not available [lp-3 ] DEBUG 2024/08/23 10:59:22 charge currents: [6.6 0.1 0.1]A [lp-4 ] DEBUG 2024/08/23 10:59:22 charge power: 0W [lp-4 ] DEBUG 2024/08/23 10:59:22 charge currents: [0 0 0]A

Was ich aber als Fehler sehe, dass die Box beim Einstecken sofort mit 6A, dann mit 16A läd und dann abgeschaltet wird. Diese Freigabe darf doch garnicht erst erteilt werden über das Backend oder?

Zudem scheint es noch ein Problem mit dem Timer zu geben, dieser resettet sich immer bei neuladen der Seite auf 2:59.

evcc-20240823-111024-trace.log

etecprojekt avatar Aug 23 '24 09:08 etecprojekt

@premultiply die MeterValues messages ist auf den ersten Blick anders als bswp. bei meinem Bender Charger, es handelt sich hier um ein Array mit 2 Objekten, das erste enthält die erfolgreich geparsten Currents, das zweite den Rest und nochmals die Currents. Evtl. ist das die Ursache? Die Fehlermeldungen korrespondieren mit den sampledValues, die im ersten Objekt nicht drin sind.

[
    2,
    "39118670",
    "MeterValues",
    {
        "connectorId": 1,
        "transactionId": 1,
        "meterValue": [
            {
                "timestamp": "2024-08-23T06:02:45.311+00:00",
                "sampledValue": [
                    {
                        "value": "6.0",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Import",
                        "phase": "L1",
                        "location": "Body",
                        "unit": "A"
                    },
                    {
                        "value": "6.0",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Import",
                        "phase": "L2",
                        "location": "Body",
                        "unit": "A"
                    },
                    {
                        "value": "5.9",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Import",
                        "phase": "L3",
                        "location": "Body",
                        "unit": "A"
                    }
                ]
            },
            {
                "timestamp": "2024-08-23T06:02:45.337+00:00",
                "sampledValue": [
                    {
                        "value": "10280.792",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Energy.Active.Import.Register",
                        "location": "Outlet",
                        "unit": "kWh"
                    },
                    {
                        "value": "4185.3",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Power.Active.Import",
                        "location": "Outlet",
                        "unit": "W"
                    },
                    {
                        "value": "5.957",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Import",
                        "phase": "L1",
                        "location": "Outlet",
                        "unit": "A"
                    },
                    {
                        "value": "6.027",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Import",
                        "phase": "L2",
                        "location": "Outlet",
                        "unit": "A"
                    },
                    {
                        "value": "5.983",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Import",
                        "phase": "L3",
                        "location": "Outlet",
                        "unit": "A"
                    },
                    {
                        "value": "236.3",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Voltage",
                        "phase": "L1-N",
                        "location": "Outlet",
                        "unit": "V"
                    },
                    {
                        "value": "234.8",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Voltage",
                        "phase": "L2-N",
                        "location": "Outlet",
                        "unit": "V"
                    },
                    {
                        "value": "235.8",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Voltage",
                        "phase": "L3-N",
                        "location": "Outlet",
                        "unit": "V"
                    },
                    {
                        "value": "6.0",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Current.Offered",
                        "location": "Outlet",
                        "unit": "A"
                    },
                    {
                        "value": "0.0",
                        "context": "Sample.Periodic",
                        "format": "Raw",
                        "measurand": "Power.Offered",
                        "location": "Outlet",
                        "unit": "kW"
                    }
                ]
            }
        ]
    }
]

Ist das die Stelle, wo das verarbeitet wird?

func (conn *Connector) MeterValues(request *core.MeterValuesRequest) (*core.MeterValuesConfirmation, error) {
	conn.mu.Lock()
	defer conn.mu.Unlock()

	if request.TransactionId != nil && conn.txnId == 0 && conn.status != nil &&
		(conn.status.Status == core.ChargePointStatusCharging ||
			conn.status.Status == core.ChargePointStatusSuspendedEV ||
			conn.status.Status == core.ChargePointStatusSuspendedEVSE) {
		conn.log.DEBUG.Printf("hijacking transaction: %d", *request.TransactionId)
		conn.txnId = *request.TransactionId
	}

	for _, meterValue := range request.MeterValue {
		// ignore old meter value requests
		if meterValue.Timestamp.Time.After(conn.meterUpdated) {
			for _, sample := range meterValue.SampledValue {
				sample.Value = strings.TrimSpace(sample.Value)
				conn.measurements[getSampleKey(sample)] = sample
				conn.meterUpdated = conn.clock.Now()
			}
		}
	}

	select {
	case conn.meterC <- conn.measurements:
	default:
	}

	return new(core.MeterValuesConfirmation), nil
}

Ohne jetzt der go Experte zu sein würde ich sagen, die for-Schleife nimmt das erste Objekt, schaut sich den Timestamp (2024-08-23T06:02:45.311+00:00) an und wenn er neuer ist als conn.meterUpdated, werden die Werte verarbeitet -> die currents werden gespeichert und conn.meterUpdated auf die aktuelle Zeit conn.clock.Now() gesetzt. Nun wird das zweite Objekt mit dem Timestamp 2024-08-23T06:02:45.337+00:00 verarbeitet. Da aber conn.clock.Now() bei Verarbeitung des ersten Objekts schon später als der Timestamp des zweiten Objekts ist, wird der Inhalt ignoriert.

mfuchs1984 avatar Aug 23 '24 09:08 mfuchs1984

Autsch, ja!! Super! Hier gibt es zwei Objekte: Einmal von der Messposition Body (für uns eigentlich eher irrelevant) und einmal Outlet.

Da muss ich erstmal überlegen wie wir damit sinnvoll umgehen.

/cc @andig

premultiply avatar Aug 23 '24 10:08 premultiply

Da aber conn.clock.Now() bei Verarbeitung des ersten Objekts schon später als der Timestamp des zweiten Objekts ist, wird der Inhalt ignoriert.

Dann sollten wir das einfach nach Timestamps sortieren (anstatt mit location rumzufrickeln)? Vorschlag kommt.

andig avatar Aug 23 '24 10:08 andig

Die Location ist hier schon auch relevant, da das hier eine Box mit zwei LPs ist und der Ladestrom beider LPs auf den Body-Werten auftaucht, wir uns hier aber nur für die Outlets (Connector) interessieren. Die Body-Werte verwirren hier nur - kann aber bei anderen Boxen wieder anders sein.

premultiply avatar Aug 23 '24 10:08 premultiply

Je nach Verhalten der Wallboxen ggf. over engineered, aber wäre es nicht am robustesten, mit dem neuesten timestamp anzufangen und dann bis zum ältesten Objekt weiterzumachen und measurands, die noch nicht gefunden wurden, daraus zu ergänzen? Dabei Outlet vor Body priorisieren?

mfuchs1984 avatar Aug 23 '24 10:08 mfuchs1984

Dabei Outlet vor Body priorisieren?

Sind die irgendwo definiert?

mit dem neuesten timestamp anzufangen und dann bis zum ältesten Objekt weiterzumachen und measurands

Umgekehrt und dann wird einfach überschrieben.

andig avatar Aug 23 '24 10:08 andig

Das würde hier vielleicht funktionieren aber in anderen Fällen (andere Boxen) ist die Reihenfolge ggf. eine andere? Ist ja leider nicht näher definiert. Und wie wir wissen macht da jeder Hersteller irgendwas anderes (wie man hier ja auch sieht). Theoretisch können die auch alle mit unterschiedlichen Locations unter einem Timestamp stehen.

Aktuell sehe ich noch keine elegante Möglichkeit das möglichst universell zu lösen. Doch irgendwie eine Priorität nach der Location machen?

premultiply avatar Aug 23 '24 10:08 premultiply

Ocpp 1.6 Specs chapter 7.30

Body Measurement inside body of Charge Point (e.g. Temperature)

Cable Measurement taken from cable between EV and Charge Point

EV Measurement taken by EV

Inlet Measurement at network (“grid”) inlet connection

Outlet Measurement at a Connector. Default value

mfuchs1984 avatar Aug 23 '24 10:08 mfuchs1984

Ich sehe hier gar kein Problem. Oder wollen wir Spannungsabfall über das Kabel messen???

andig avatar Aug 23 '24 10:08 andig

Nein, aber wir wollen auch nicht zufällige Sprünge in den Currents sehen?

premultiply avatar Aug 23 '24 10:08 premultiply

...dann könnte man in anderer Logik nach Zeit und Location sortieren. Dafür müssten die verschachtelten Listen erst gemerged werden?

andig avatar Aug 23 '24 10:08 andig

Das geht aus meiner Sicht in die richtige Richtung.

premultiply avatar Aug 23 '24 10:08 premultiply

Mit dem PR bleibt das Grundroblem doch bestehen, oder? Da conn.meterUpdated auf conn.clock.Now() gesetzt wird, was definitiv später als die Timestamps ist, wird alles nach dem ersten Objekt in der nun sortierten Liste nicht verarbeitet. Steht zufällig das Benötigte im ersten Objekt der sortierte Liste, ist alles gut, wenn nicht, fehlt was. Oder übersehe ich was?

for _, meterValue := range sortByAge(request.MeterValue) {
      // ignore old meter value requests
      if meterValue.Timestamp.Time.After(conn.meterUpdated) {
	      for _, sample := range meterValue.SampledValue {
		      sample.Value = strings.TrimSpace(sample.Value)
		      conn.measurements[getSampleKey(sample)] = sample
		      conn.meterUpdated = conn.clock.Now()
	      }
      }
}

Man müsste meines Erachtens nur einen der Timestamp im request für die Prüfung meterValue.Timestamp.Time.After(conn.meterUpdated) heranziehen, danach alle Objekte verarbeiten und anschließend erst conn.meterUpdated = conn.clock.Now() aufrufen.

mfuchs1984 avatar Aug 23 '24 10:08 mfuchs1984