poohnet

... oder vielleicht sogar eine direkte Anbindung der API von tibber? Alternativ den Preis vor dem Start der Ladung per MQTT setzen? Gruß Thomas

Guten Morgen, gibt es zu euren Gehäusen für die Bricks/Bricklets zufällig STL-Files oder andere Dateien, mit denen man einen 3D-Drucker füttern könnte? Vielen Dank & Gruß Thomas

Moin @Fabix, der in der WARP1 verbaute ESP32-Brick ist leider etwas zu "schwachbrüstig" für die OCPP-Funktionen. Ich habe meinen WARP-Charger daher auf den ESP32-Ethernet-Brick aufgerüstet und die Firmware entsprechend angepasst, sodass diese auch mit dem "alten" Ladecontroller funktioniert. Guck' mal hier: Gruß Thomas

Alles klar, besten Dank 😊 Ich ziehe die letzten Anpassungen dann auch noch nach und teste weiter. Falls wir uns nicht mehr hören sollten, so wünsche ich euch auf jeden Fall schon mal frohe Weihnachten und einen guten Rutsch. Ich bin froh, mich vor mittlerweile fast zwei Jahren für WARP entschieden zu haben und bin gespannt, was ihr 2023 noch so alles implementieren werdet… Gruß Thomas

Hallo @rtrbt, ich bin jetzt mal auf die aktuelle Version gegangen und habe unter "lib_deps" die neueste Revision von tfocpp eingebunden (9856852). Leider gibt es hier jetzt einen Compile-Fehler: src/modules/ocpp/ocpp.cpp: In member function 'void Ocpp::setup()': src/modules/ocpp/ocpp.cpp:117:109: error: no matching function for call to 'OcppChargePoint::start(const char*, const char*)' cp.start(config.get("url")->asEphemeralCStr(), (String(BUILD_HOST_PREFIX) + '-' + local_uid_str).c_str()); ^ In file included from src/modules/ocpp/ocpp.h:23, from src/modules/ocpp/ocpp.cpp:20: .pio/libdeps/warp2_poohnet/TFOCPP/src/ocpp/ChargePoint.h:46:10: note: candidate: 'void OcppChargePoint::start(const char*, const char*, const char*)' void start(const char *websocket_endpoint_url, const char *charge_point_name, const char *basic_auth_pass); ^~~~~ .pio/libdeps/warp2_poohnet/TFOCPP/src/ocpp/ChargePoint.h:46:10: note: candidate expects 3 arguments, 2 provided Anscheinend fehlt da noch was im Repo... Gruß Thomas

Moin @rtrbt, vielen Dank für die Rückmeldung. Sind denn alle relevanten Commits auch im GitHub-Repo? Dann würde ich die nochmal in meinen Fork nachziehen und weiter testen... Gruß Thomas

Hallo @rtrbt, konntet ihr zwischenzeitlich schon etwas herausfinden? Ich hatte gestern wieder den Fall, dass das Ende der Ladung bei eCarUp nicht korrekt erkannt wurde und diese nun mit 0,0 kWh in der App steht... Vielen Dank & Gruß Thomas

Alles klar, danke :-)

Moin @rtrbt, gibt es schon irgendwelche neuen Erkenntnisse? Vielen Dank & Gruß Thomas

Hi @rtrbt, wie versprochen hier die Vorgehensweise zur Reproduktion des Problems mit SteVe: Fahrzeug verbinden EVCC nicht (!) freigeben RemoteStartTransaction senden etwas warten RemoteStopTransaction senden --> Transaktion bleibt in SteVe aktiv RemoteStopTransaction erneut senden --> Transaktion wird rejected Anbei noch das Log... Gruß Thomas steve.txt

Hab ich mich noch nicht getraut, aber wahrscheinlich laufe ich demnächst eh wieder in eine Situation, bei dem ich den OCPP-Status zurücksetzen muss… 🙃 Ich probiere das morgen Nachmittag nochmal aus und hänge die Logs an.

'n Abend @rtrbt, ich habe mich heute Nachmittag mal etwas mit SteVe beschäftigt und kann das Problem auch hier reproduzieren. Wenn zwischen "RemoteStartTransaction" und "RemoteStopTransaction" kein "Sending StatusNotification.req: Status Charging for connector 1" gesendet wird, dann wird "RemoteStopTransaction" zwar mit "Accepted" quittiert, die Transaktion bleibt aber offen. Weitere "RemoteStopTransaction" werden von WARP dann mit "unknown transaction id" rejected. Ist das evtl. eine Definitionslücke in der Spezifikation? Gruß Thomas

Hallo @rohrbage, hast du evtl. versehentlich den max. Strom begrenzt? Falls nein, geh mal auf die Seite „Ladecontroller“ und erstelle ein Ladeprotokoll (d. h. Ladeprotokoll starten, Ladung starten, ein paar Minuten laufen lassen, Ladung beenden und Ladeprotokoll herunterladen). Das Protokoll kannst du hier anhängen, sodass die Jungs von TF es analysieren können… Gruß Thomas

Moin @rtrbt, so, ich habe heute Vormittag eine ganze Reihe Tests gemacht und die gute Nachricht ist, dass im Normalfall nun anscheinend alles richtig funktioniert! Vielen Dank dafür 🙂 Allerdings habe ich es (mit einer zugegebenermaßen nicht ganz sauberen Vorhensweise) trotzdem reproduzierbar geschafft, WARP und eCarUp doch noch aus dem Tritt zu bringen. Wenn man nämlich eine Ladung über die eCarUp-App startet und diese anschließend wieder beendet, ohne zuvor EVCC freigegeben zu haben (also letztendlich gar nicht lädt), dann bleibt der Ladevorgang in der App weiterhin aktiv und WARP bekommt wieder keine Heartbeats mehr: 2022-11-26 12:20:34,132 Sending Heartbeat.req. 197608 197608 257608 60000 2022-11-26 12:20:34,230 Received Heartbeat.conf for connector 0 2022-11-26 12:21:33,961 Sending Heartbeat.req. 257669 257669 317669 60000 2022-11-26 12:21:34,059 Received Heartbeat.conf for connector 0 2022-11-26 12:21:46,422 IDLE -> NO_TAG 2022-11-26 12:21:46,423 Sending StatusNotification.req: Status Preparing for connector 1 2022-11-26 12:21:46,512 Received StatusNotification.conf for connector 1 2022-11-26 12:21:46,885 Charger state changed from 0 to 1 2022-11-26 12:22:17,600 Wrote last uptime to flash 2022-11-26 12:22:20,942 Received RemoteStartTransaction.req for connector 1 and tag TV2DVLAZELX3FLCHVS5A 2022-11-26 12:22:20,942 Sending RemoteStartTransaction.conf Accepted 2022-11-26 12:22:20,958 NO_TAG -> TRANSACTION 2022-11-26 12:22:21,001 Sending StartTransaction.req at connector 1 for tag TV2DVLAZELX3FLCHVS5A at 741.195 kWh. 2022-11-26 12:22:21,007 Sending StatusNotification.req: Status SuspendedEVSE for connector 1 2022-11-26 12:22:21,022 Evaluating charging profiles 2022-11-26 12:22:21,022 Connector 1 2022-11-26 12:22:21,023 Profile evaluation done. Distributing limit 2022-11-26 12:22:21,033 Currents distributed: 2022-11-26 12:22:21,033 ConnID Allowed Phases MinRate 2022-11-26 12:22:21,044 0 32.000 3 0.000 2022-11-26 12:22:21,044 1 32.000 3 0.000 2022-11-26 12:22:21,045 Next check: never 2022-11-26 12:22:21,055 2022-11-26 12:22:21,055 Setting connector 1 limit to 32000 2022-11-26 12:22:21,106 Received StartTransaction.conf for connector 1 2022-11-26 12:22:21,172 Evaluating charging profiles 2022-11-26 12:22:21,173 Connector 1 2022-11-26 12:22:21,173 Profile evaluation done. Distributing limit 2022-11-26 12:22:21,183 Currents distributed: 2022-11-26 12:22:21,183 ConnID Allowed Phases MinRate 2022-11-26 12:22:21,194 0 32.000 3 0.000 2022-11-26 12:22:21,195 1 32.000 3 0.000 2022-11-26 12:22:21,195 Next check: never 2022-11-26 12:22:21,205 2022-11-26 12:22:21,206 Setting connector 1 limit to 32000 2022-11-26 12:22:21,263 Received StatusNotification.conf for connector 1 2022-11-26 12:22:33,910 Sending Heartbeat.req. 317677 317677 377677 60000 2022-11-26 12:22:34,002 Received Heartbeat.conf for connector 0 2022-11-26 12:23:33,985 Sending Heartbeat.req. 377754 377754 437754 60000 2022-11-26 12:23:34,088 Received Heartbeat.conf for connector 0 2022-11-26 12:23:48,441 Received RemoteStopTransaction.req for txn 1669461741 2022-11-26 12:23:48,442 TRANSACTION -> FINISHING_UNLOCKED 2022-11-26 12:23:48,476 Sending StatusNotification.req: Status Finishing for connector 1 2022-11-26 12:23:48,522 Sending StopTransaction.req at connector 1 for tag at 741.195 kWh. StopReason 7 2022-11-26 12:23:48,553 Sending RemoteStopTransaction.conf Accepted (connector 0) 2022-11-26 12:23:48,570 Evaluating charging profiles 2022-11-26 12:23:48,571 Connector 1 2022-11-26 12:23:48,571 Profile evaluation done. Distributing limit 2022-11-26 12:23:48,581 Currents distributed: 2022-11-26 12:23:48,582 ConnID Allowed Phases MinRate 2022-11-26 12:23:48,592 0 32.000 3 0.000 2022-11-26 12:23:48,593 1 32.000 3 0.000 2022-11-26 12:23:48,593 Next check: never 2022-11-26 12:23:48,603 2022-11-26 12:23:48,604 Setting connector 1 limit to 32000 2022-11-26 12:23:48,658 Received StatusNotification.conf for connector 1 2022-11-26 12:24:33,899 Sending Heartbeat.req. 437757 437757 497757 60000 2022-11-26 12:25:33,998 Sending Heartbeat.req. 497857 497857 557857 60000 2022-11-26 12:25:51,441 FINISHING_UNLOCKED -> IDLE 2022-11-26 12:25:51,442 Sending StatusNotification.req: Status Available for connector 1 2022-11-26 12:25:52,015 Charger state changed from 1 to 0 2022-11-26 12:26:34,021 Sending Heartbeat.req. 557879 557879 617879 60000 Beim Zurücksetzen des OCPP-Status bin ich dann auch noch über einen bösen Bug gestolpert, denn dieser scheint in der aktuellen Version nun einem Factory-Reset gleichzukommen. Jedenfalls war anschließend meine gesamte Konfiguration inkl. aller aufgezeichneter Ladevorgänge weg... 😢 Nachdem ich alles wieder richtig eingestellt hatte, hat es übrigens noch fast 20 Minuten gedauert, bis WARP und eCarUp wieder "in sync" waren. Die App hat nämlich im Minutentakt weiterhin "RemoteStopTransaction.req" gesendet, die aber von WARP zurückgewiesen wurden. Irgendwann hat das dann aber aufgehört und die Box wurde wieder als "frei" aufgeführt. 16,564 OCPP WEBSOCKET CONNECTED 16,642 Sending BootNotification.req. 16641 0 60000 60000 16,744 Received BootNotification.conf for connector 0. Interval 60 2022-11-26 12:39:00,000 Sending StatusNotification.req: Status Available for connector 0 2022-11-26 12:39:00,011 Sending StatusNotification.req: Status Available for connector 1 2022-11-26 12:39:00,030 Sending StatusNotification.req: Status Available for connector 0 2022-11-26 12:39:00,046 Evaluating charging profiles 2022-11-26 12:39:00,047 Connector 1 2022-11-26 12:39:00,047 Profile evaluation done. Distributing limit 2022-11-26 12:39:00,057 Currents distributed: 2022-11-26 12:39:00,057 ConnID Allowed Phases MinRate 2022-11-26 12:39:00,068 0 32.000 3 0.000 2022-11-26 12:39:00,069 1 32.000 3 0.000 2022-11-26 12:39:00,069 Next check: never 2022-11-26 12:39:00,079 2022-11-26 12:39:00,079 Setting connector 1 limit to 32000 2022-11-26 12:39:00,147 Received StatusNotification.conf for connector 0 2022-11-26 12:39:00,287 Received StatusNotification.conf for connector 1 2022-11-26 12:39:00,399 Received StatusNotification.conf for connector 0 2022-11-26 12:39:04,077 NTP synchronized at 20,446! 2022-11-26 12:39:24,242 Received RemoteStopTransaction.req for txn 1669461741 2022-11-26 12:39:24,242 Sending RemoteStopTransaction.conf Rejected (unknown transaction id) 2022-11-26 12:39:49,672 This is warp2-XSS (warp2-XSS), a WARP2 Charger Pro 11kW 2022-11-26 12:40:00,344 Sending Heartbeat.req. 76713 76713 136713 60000 2022-11-26 12:40:00,442 Received Heartbeat.conf for connector 0 2022-11-26 12:40:25,495 Received RemoteStopTransaction.req for txn 1669461741 2022-11-26 12:40:25,495 Sending RemoteStopTransaction.conf Rejected (unknown transaction id) 2022-11-26 12:40:59,951 Sending Heartbeat.req. 136763 136763 196763 60000 2022-11-26 12:41:01,946 Received Heartbeat.conf for connector 0 2022-11-26 12:41:29,315 Received RemoteStopTransaction.req for txn 1669461741 2022-11-26 12:41:29,315 Sending RemoteStopTransaction.conf Rejected (unknown transaction id) 2022-11-26 12:42:00,084 Sending Heartbeat.req. 196843 196843 256843 60000 2022-11-26 12:42:00,182 Received Heartbeat.conf for connector 0 2022-11-26 12:42:29,979 Received RemoteStopTransaction.req for txn 1669461741 2022-11-26 12:42:29,979 Sending RemoteStopTransaction.conf Rejected (unknown transaction id) Gruß Thomas

Wow, super 🤩 Ich baue dann morgen mal eine neue Version und teste weiter… Gruß und ein schönes Wochenende Thomas

Ok, das ist tatsächlich interessant. Ich habe nochmal in die alten Logs geschaut und kann bestätigen, dass überall da, wo es ein Problem beim Start des Ladevorgangs gab, kein "StartTransaction.req" geschickt wurde. Ich versuche mal, ob ich das durch eine längere Wartezeit zwischen Verbinden und Start reproduziert bekomme...

Moin @rtrbt, nachdem ich jetzt einige erfolgreiche Ladevorgänge über eCarUp durchführen konnte, ist gestern Abend wieder ein ähnliches Problem wie in Test 1 aufgetreten, das nur durch ein Zurücksetzen des OCPP-Status gelöst werden konnte: 17:38 - Fahrzeug verbunden --> eCarUp-Status wechselt von "Frei" auf "Verbunden" ✔️ 17:40 - Ladung per EVCC freigeschaltet (Min+PV) --> EVCC-Status wechselt auf "Ladebereit, warte auf Fahrzeug" ✔️ 17:40 - Ladung per eCarUp-App gestartet --> WARP startet Ladung, eCarUp-Status wechselt kurz auf "Besetzt", springt dann aber auf "Verbunden" zurück ❌ 17:43 - Fahrzeug getrennt --> keine Heartbeats mehr ❌ 17:46 - WARP neugestartet --> "RESTORED StopTransaction.req" wird bei jedem Neustart gesendet, es kommen aber trotzdem keine Heartbeats ❌ 17:49 - OCPP-Status zurückgesetzt u. WARP neugestartet --> Heartbeats kommen wieder an ✔️ Wenn ich das Protokoll richtig interpretiere, dann war die Zeit zwischen dem Verbinden des Fahrzeugs und dem Start der Ladung über die eCarUp-App zu lang, sodass nach dem Status "Preparing" schon ein "Finishing" geschickt wurde: 2022-11-24 17:38:10,993 Sending Heartbeat.req. 525637161 525637161 525697161 60000 2022-11-24 17:38:11,093 Received Heartbeat.conf for connector 0 2022-11-24 17:38:19,790 IDLE -> NO_TAG 2022-11-24 17:38:19,790 Sending StatusNotification.req: Status Preparing for connector 1 2022-11-24 17:38:19,888 Received StatusNotification.conf for connector 1 2022-11-24 17:38:20,206 Charger state changed from 0 to 1 2022-11-24 17:39:10,899 Sending Heartbeat.req. 525697161 525697161 525757161 60000 2022-11-24 17:39:11,000 Received Heartbeat.conf for connector 0 2022-11-24 17:39:19,797 Tag timeout! 2022-11-24 17:39:19,797 NO_TAG -> FINISHING_UNLOCKED 2022-11-24 17:39:19,798 Sending StatusNotification.req: Status Finishing for connector 1 2022-11-24 17:39:19,907 Received StatusNotification.conf for connector 1 2022-11-24 17:40:10,901 Sending Heartbeat.req. 525757163 525757163 525817163 60000 2022-11-24 17:40:10,997 Received Heartbeat.conf for connector 0 2022-11-24 17:40:33,080 Evaluating charging profiles 2022-11-24 17:40:33,080 Connector 1 2022-11-24 17:40:33,080 Profile evaluation done. Distributing limit 2022-11-24 17:40:33,091 Currents distributed: 2022-11-24 17:40:33,091 ConnID Allowed Phases MinRate 2022-11-24 17:40:33,102 0 32.000 3 0.000 2022-11-24 17:40:33,102 1 32.000 3 0.000 2022-11-24 17:40:33,102 Next check: never 2022-11-24 17:40:33,113 2022-11-24 17:40:33,113 Setting connector 1 limit to 32000 2022-11-24 17:40:55,180 Received RemoteStartTransaction.req for connector 1 and tag E7ZYQ3X3G2FAAVJTWWDA 2022-11-24 17:40:55,180 Sending RemoteStartTransaction.conf Accepted 2022-11-24 17:40:55,196 FINISHING_UNLOCKED -> TRANSACTION 2022-11-24 17:40:55,263 Sending StatusNotification.req: Status SuspendedEVSE for connector 1 2022-11-24 17:40:55,364 Received StatusNotification.conf for connector 1 2022-11-24 17:40:55,371 Sending StatusNotification.req: Status SuspendedEV for connector 1 2022-11-24 17:40:55,460 Received StatusNotification.conf for connector 1 2022-11-24 17:40:56,303 Charger state changed from 1 to 2 2022-11-24 17:40:56,379 Tracked start of charge. 2022-11-24 17:40:57,230 Sending StatusNotification.req: Status Charging for connector 1 2022-11-24 17:40:57,318 Received StatusNotification.conf for connector 1 2022-11-24 17:40:57,385 Charger state changed from 2 to 3 2022-11-24 17:41:10,929 Sending Heartbeat.req. 525817189 525817189 525877189 60000 2022-11-24 17:41:11,021 Received Heartbeat.conf for connector 0 2022-11-24 17:42:10,977 Sending Heartbeat.req. 525877259 525877259 525937259 60000 2022-11-24 17:42:11,077 Received Heartbeat.conf for connector 0 2022-11-24 17:43:07,152 Sending StatusNotification.req: Status SuspendedEV for connector 1 2022-11-24 17:43:07,252 Received StatusNotification.conf for connector 1 2022-11-24 17:43:07,404 Charger state changed from 3 to 2 2022-11-24 17:43:10,932 Sending Heartbeat.req. 525937292 525937292 525997292 60000 2022-11-24 17:43:11,035 Received Heartbeat.conf for connector 0 2022-11-24 17:43:11,205 Unexpected EVSEState 0 while Connector is in state 8. Aborting transaction! 2022-11-24 17:43:11,205 TRANSACTION -> FINISHING_NO_CABLE_UNLOCKED 2022-11-24 17:43:11,251 Sending StopTransaction.req at connector 1 for tag E7ZYQ3X3G2FAAVJTWWDA at 739.726 kWh. StopReason 1 2022-11-24 17:43:11,285 Sending StatusNotification.req: Status Finishing for connector 1 2022-11-24 17:43:11,302 Evaluating charging profiles 2022-11-24 17:43:11,302 Connector 1 2022-11-24 17:43:11,303 Profile evaluation done. Distributing limit 2022-11-24 17:43:11,313 Currents distributed: 2022-11-24 17:43:11,313 ConnID Allowed Phases MinRate 2022-11-24 17:43:11,324 0 32.000 3 0.000 2022-11-24 17:43:11,324 1 32.000 3 0.000 2022-11-24 17:43:11,335 Next check: never 2022-11-24 17:43:11,335 2022-11-24 17:43:11,335 Setting connector 1 limit to 32000 2022-11-24 17:43:11,398 Charger state changed from 2 to 0 2022-11-24 17:43:11,486 Tracked end of charge. 2022-11-24 17:43:11,639 FINISHING_NO_CABLE_UNLOCKED -> IDLE 2022-11-24 17:43:11,639 Sending StatusNotification.req: Status Available for connector 1 2022-11-24 17:44:10,948 Sending Heartbeat.req. 525997344 525997344 526057344 60000 2022-11-24 17:45:11,011 Sending Heartbeat.req. 526057407 526057407 526117407 60000 Kann es sein, dass WARP und eCarUp hier aus dem Tritt kommen? Gruß Thomas

Ah, jetzt, ja… 😉 Hut ab, ihr treibt ja wirklich einen immensen Aufwand, die Bugs zu jagen! Interessant ist aber, dass sich eCarUp und WARP so verheddern, dass nur ein Zurücksetzen des OCPP-Status das Problem löst. Ich bin gespannt, was die Jungs zu dem Bugreport sagen… In der Zwischenzeit werde ich jetzt mal zwei Dinge testen: „normale“ Ladevorgänge, d. h. verbinden, starten, stoppen, trennen. Mal schau‘n, ob ich den Fall aus Test 2 auch irgendwie reproduziert bekomme. Aufbau einer VM mit SteVe und gleiche Tests Gruß Thomas

Sehr gut 👍 Ich habe es heute Morgen auch nochmal probiert und konnte den Fehlerfall aus Test 1 wieder reproduzieren. Man muss nur eine Ladung starten, beenden und wieder starten, ohne das Ladekabel zwischenzeitlich zu trennen. Brauchst du das Debug-Log mit den neuen Informationen zum OCPP-Zustand? Ja, kann ich bestätigen 😀

Vielen Dank für deine Unterstützung Erik, ich werd's am Wochenende testen. Habt ihr zwischenzeitlich eigentlich noch weitere Rückmeldungen zu OCPP bekommen? Oder bin ich der einzige, der das testet? Gruß Thomas

Moin @rtrbt, leider sind beide Probleme bei meinen gestrigen Tests mit dem aktuellen Entwicklungsstand erneut aufgetreten 🙁 Nur zur Sicherheit (damit wir keine Phantome jagen), bei mir gibt's ja zwei Besonderheiten: WARP1 Smart umgerüstet auf ESP32-Ethernet-Brick Zählerstände werden per MQTT (values_update, phases_update etc.) geschickt, d. h. es ist kein interner Zähler verbaut Test 1 18:24 - Fahrzeug verbunden --> eCarUp-Status wechselt von "Frei" auf "Verbunden" ✔️ 18:24 - Ladung per EVCC freigeschaltet (Min+PV) --> EVCC-Status wechselt auf "Ladebereit, warte auf Fahrzeug" ✔️ 18:25 - Ladung per eCarUp-App gestartet --> WARP startet Ladung, eCarUp-Status wechselt von "Verbunden" auf "Besetzt" ✔️ 18:35 - Ladung per eCarUp-App beendet --> WARP stoppt Ladung, eCarUp-Status wechselt von "Besetzt" auf "Verbunden" ✔️ 18:35 - neue Ladung per eCarUp-App gestartet --> WARP startet Ladung, eCarUp-Status wechselt kurz auf "Besetzt", springt dann aber auf "Verbunden" zurück ❌ 18:37 - Ladung per EVCC abgebrochen, Fahrzeug getrennt --> keine Heartbeats mehr ❌ 18:41 - WARP 2x neugestartet --> "RESTORED StopTransaction.req" wird bei jedem Neustart gesendet, es kommen aber trotzdem keine Heartbeats ❌ 18:46 - OCPP-Status zurückgesetzt u. WARP neugestartet --> Heartbeats kommen wieder an ✔️ Test 2 18:48 - Fahrzeug verbunden --> eCarUp-Status wechselt von "Frei" auf "Verbunden" ✔️ 18:48 - Ladung per EVCC freigeschaltet (Min+PV) --> EVCC-Status wechselt auf "Ladebereit, warte auf Fahrzeug" ✔️ 18:49 - Ladung per eCarUp-App gestartet --> WARP startet Ladung, eCarUp-Status wechselt von "Verbunden" auf "Besetzt" ✔️ 18:59 - Ladung per eCarUp-App beendet --> WARP stoppt Ladung, eCarUp-Status bleibt bei "Besetzt" und Ladezeit läuft weiter ❌ 19:00 - Ladung erneut per eCarUp-App beendet --> keine Änderung ❌ 19:01 - Fahrzeug getrennt --> keine Heartbeats mehr, Status bleibt "Besetzt", Ladezeit läuft weiter ❌ 19:03 - WARP neugestartet --> "RESTORED StopTransaction.req" erfolgreich gesendet, Heartbeats kommen wieder an ✔️ Hast du noch irgendwelche Ideen? Gerne können wir hierzu auch mal telefonieren... Vielen Dank und Gruß Thomas test1.txt test2.txt

Das war kaputt. Weil ich da direkt von TRANSACTION nach IDLE gehe, schicke ich nie die StopTransaction-Nachricht raus. Habe ich gerade gefixt. Moin @rtrbt, gibst du Bescheid, sobald der Fix im Repo ist? Dann teste ich diesen gerne... Danke & Gruß Thomas

Moin, an L1 hängt die Stromversorgung der WARP-Komponenten, d. h. wenn du die Phase wegnimmst, dann ist die Box aus. L2 und L3 werden IMHO durch das Schütz nur durchgeschaltet… Gruß Thomas

Tja, wenn ich das wüsste 😂 Ladekabel verbunden, EVCC freigeschaltet, Ladevorgang über eCarUp-App gestartet. WARP startet und der Status bei eCarUp geht kurz auf "Besetzt", springt nach ein paar Sekunden aber wieder zurück auf "Verbunden", obwohl das Fahrzeug geladen wird. Ich habe dann einfach nochmal auf "Starten" geklickt. Erst nach Trennen und Neuverbinden des Fahrzeugs konnte der Ladevorgang dann richtig gestartet werden, sodass WARP und eCarUp "in sync" waren...

Danke Erik, das klingt sehr interessant 🙂 Ich habe in den letzten Tagen übrigens mal etwas getestet und das Ergebnis war "so halbwegs" erfolgreich. Folgendes Testszenario habe ich mehrfach hintereinander an unterschiedlichen Tagen durchgespielt, i. d. R. ohne WARP zwischendurch neuzustarten. Ladekabel verbinden EVCC freischalten (Min+PV) --> Status "Ladebereit, Warte auf Fahrzeug" Ladevorgang in eCarUp-App starten (10-15 Minuten) --> WARP startet Nach Ende des Ladevorgangs Ladekabel trennen Meistens hat dies auch richtig funktioniert, allerdings hatte ich zweimal den Fall, dass der Ladevorgang zwar gestartet wurde, eCarUp dies aber nicht mitbekommen hat. Der Status geht dann kurz auf "Besetzt", nach einigen Sekunden aber wieder auf "Verbunden". obwohl das Auto geladen wird. Erst nach einer kompletten Wiederholung des o. g. Ablaufs (d. h. einem Neuverbinden) hat es korrekt funktioniert. Hier die zugehörigen Logs: 2022-11-01 09:55:05,898 Sending Heartbeat.req. 63316158 63316158 63376158 60000 2022-11-01 09:55:06,005 Received message [3, "1057", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 09:55:06,006 Received Heartbeat.conf for connector 0 2022-11-01 09:56:05,958 Sending Heartbeat.req. 63376234 63376234 63436234 60000 2022-11-01 09:56:06,062 Received message [3, "1058", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 09:56:06,064 Received Heartbeat.conf for connector 0 2022-11-01 09:56:33,506 IDLE -> NO_TAG 2022-11-01 09:56:33,507 Sending StatusNotification.req: Status Preparing for connector 1 2022-11-01 09:56:33,610 Received message [3, "1059", {}] (len 15) 2022-11-01 09:56:33,611 Received StatusNotification.conf for connector 1 2022-11-01 09:56:33,950 Charger state changed from 0 to 1 2022-11-01 09:57:05,952 Sending Heartbeat.req. 63436303 63436303 63496303 60000 2022-11-01 09:57:06,089 Received message [3, "1060", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 09:57:06,090 Received Heartbeat.conf for connector 0 2022-11-01 09:57:34,491 Tag timeout! 2022-11-01 09:57:34,491 NO_TAG -> FINISHING_UNLOCKED 2022-11-01 09:57:34,492 Sending StatusNotification.req: Status Finishing for connector 1 2022-11-01 09:57:34,602 Received message [3, "1061", {}] (len 15) 2022-11-01 09:57:34,603 Received StatusNotification.conf for connector 1 2022-11-01 09:57:56,929 Received message [2, "9b0e0004-6590-7235-bc49-999d0fdf276 (len 119) 2022-11-01 09:57:56,930 Received RemoteStartTransaction.req for connector 1 and tag S226J6TYXMWLADFAASWA 2022-11-01 09:57:56,941 Sending RemoteStartTransaction.conf Accepted 2022-11-01 09:57:56,958 FINISHING_UNLOCKED -> TRANSACTION 2022-11-01 09:57:57,008 Sending StatusNotification.req: Status SuspendedEVSE for connector 1 2022-11-01 09:57:57,073 Received message [3, "1062", {}] (len 15) 2022-11-01 09:57:57,073 Received StatusNotification.conf for connector 1 2022-11-01 09:57:57,112 Sending StatusNotification.req: Status SuspendedEV for connector 1 2022-11-01 09:57:57,216 Received message [3, "1063", {}] (len 15) 2022-11-01 09:57:57,216 Received StatusNotification.conf for connector 1 2022-11-01 09:57:57,865 Charger state changed from 1 to 2 2022-11-01 09:57:57,918 Tracked start of charge. 2022-11-01 09:57:59,148 Sending StatusNotification.req: Status Charging for connector 1 2022-11-01 09:57:59,242 Received message [3, "1064", {}] (len 15) 2022-11-01 09:57:59,243 Received StatusNotification.conf for connector 1 2022-11-01 09:57:59,920 Charger state changed from 2 to 3 2022-11-01 09:58:06,908 Sending Heartbeat.req. 63496360 63496360 63556360 60000 2022-11-01 09:58:07,009 Received message [3, "1065", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 09:58:07,010 Received Heartbeat.conf for connector 0 2022-11-01 09:58:36,029 Received message [2, "74670004-79cd-2c49-1e43-8e81533d30f (len 119) 2022-11-01 09:58:36,030 Received RemoteStartTransaction.req for connector 1 and tag B7YKBU4DF5A8G5FE3VVQ 2022-11-01 09:58:36,041 Sending RemoteStartTransaction.conf Accepted 2022-11-01 09:58:36,057 Ignoring remote start transaction in state TRANSACTION 2022-11-01 09:59:06,946 Sending Heartbeat.req. 63556419 63556419 63616419 60000 2022-11-01 09:59:07,051 Received message [3, "1066", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 09:59:07,052 Received Heartbeat.conf for connector 0 2022-11-01 09:59:12,320 Sending StatusNotification.req: Status SuspendedEVSE for connector 1 2022-11-01 09:59:12,424 Received message [3, "1067", {}] (len 15) 2022-11-01 09:59:12,425 Received StatusNotification.conf for connector 1 2022-11-01 09:59:12,876 Charger state changed from 3 to 1 2022-11-01 09:59:23,267 Sending StatusNotification.req: Status SuspendedEV for connector 1 2022-11-01 09:59:23,388 Received message [3, "1068", {}] (len 15) 2022-11-01 09:59:23,389 Received StatusNotification.conf for connector 1 2022-11-01 09:59:23,877 Charger state changed from 1 to 2 2022-11-01 09:59:24,275 Sending StatusNotification.req: Status Charging for connector 1 2022-11-01 09:59:24,377 Received message [3, "1069", {}] (len 15) 2022-11-01 09:59:24,378 Received StatusNotification.conf for connector 1 2022-11-01 09:59:24,896 Charger state changed from 2 to 3 2022-11-01 09:59:28,119 Sending StatusNotification.req: Status SuspendedEVSE for connector 1 2022-11-01 09:59:28,221 Received message [3, "1070", {}] (len 15) 2022-11-01 09:59:28,221 Received StatusNotification.conf for connector 1 2022-11-01 09:59:28,914 Charger state changed from 3 to 1 2022-11-01 10:00:00,049 Unexpected EVSEState 0 while Connector is in state 8. Aborting transaction! 2022-11-01 10:00:00,049 TRANSACTION -> IDLE 2022-11-01 10:00:00,061 Sending StatusNotification.req: Status Available for connector 1 2022-11-01 10:00:00,157 Received message [3, "1071", {}] (len 15) 2022-11-01 10:00:00,158 Received StatusNotification.conf for connector 1 2022-11-01 10:00:00,914 Charger state changed from 1 to 0 2022-11-01 10:00:00,968 Tracked end of charge. 2022-11-01 10:00:06,896 Sending Heartbeat.req. 63616431 63616431 63676431 60000 2022-11-01 10:00:07,004 Received message [3, "1072", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 10:00:07,005 Received Heartbeat.conf for connector 0 2022-11-01 10:00:13,909 IDLE -> NO_TAG 2022-11-01 10:00:13,910 Sending StatusNotification.req: Status Preparing for connector 1 2022-11-01 10:00:14,000 Received message [3, "1073", {}] (len 15) 2022-11-01 10:00:14,001 Received StatusNotification.conf for connector 1 2022-11-01 10:00:14,042 Charger state changed from 0 to 1 2022-11-01 10:00:35,415 Received message [2, "39ad0004-65b1-2d48-9145-919c1e2ba66 (len 119) 2022-11-01 10:00:35,416 Received RemoteStartTransaction.req for connector 1 and tag V5Y2L8A38YEC7QHAZBLQ 2022-11-01 10:00:35,427 Sending RemoteStartTransaction.conf Accepted 2022-11-01 10:00:35,442 NO_TAG -> TRANSACTION 2022-11-01 10:00:35,469 Sending StartTransaction.req at connector 1 for tag V5Y2L8A38YEC7QHAZBLQ at 725.496 kWh. 2022-11-01 10:00:35,535 Sending StatusNotification.req: Status SuspendedEVSE for connector 1 2022-11-01 10:00:35,663 Received message [3, "1074", {"idTagInfo":{"status":"Acce (len 115) 2022-11-01 10:00:35,679 Received StartTransaction.conf for connector 1 2022-11-01 10:00:35,844 Received message [3, "1075", {}] (len 15) 2022-11-01 10:00:35,845 Received StatusNotification.conf for connector 1 2022-11-01 10:00:35,856 Sending StatusNotification.req: Status SuspendedEV for connector 1 2022-11-01 10:00:35,961 Received message [3, "1076", {}] (len 15) 2022-11-01 10:00:35,962 Received StatusNotification.conf for connector 1 2022-11-01 10:00:36,044 Charger state changed from 1 to 2 2022-11-01 10:00:36,102 Tracked start of charge. 2022-11-01 10:00:36,609 Sending StatusNotification.req: Status Charging for connector 1 2022-11-01 10:00:36,703 Received message [3, "1077", {}] (len 15) 2022-11-01 10:00:36,705 Received StatusNotification.conf for connector 1 2022-11-01 10:00:37,107 Charger state changed from 2 to 3 2022-11-01 10:01:06,917 Sending Heartbeat.req. 63676468 63676468 63736468 60000 2022-11-01 10:01:07,042 Received message [3, "1078", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 10:01:07,044 Received Heartbeat.conf for connector 0 2022-11-01 10:02:06,961 Sending Heartbeat.req. 63736568 63736568 63796568 60000 2022-11-01 10:02:07,067 Received message [3, "1079", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 10:02:07,068 Received Heartbeat.conf for connector 0 2022-11-01 10:03:06,915 Sending Heartbeat.req. 63796600 63796600 63856600 60000 2022-11-01 10:03:07,019 Received message [3, "1080", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 10:03:07,020 Received Heartbeat.conf for connector 0 2022-11-01 10:04:06,903 Sending Heartbeat.req. 63856619 63856619 63916619 60000 2022-11-01 10:04:07,008 Received message [3, "1081", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 10:04:07,009 Received Heartbeat.conf for connector 0 2022-11-01 10:05:06,925 Sending Heartbeat.req. 63916662 63916662 63976662 60000 2022-11-01 10:05:07,013 Received message [3, "1082", {"currentTime":"2022-11-01T0 (len 55) 2022-11-01 10:05:07,014 Received Heartbeat.conf for connector 0 Einmal ist dann auch das ursprüngliche Problem aufgetreten, d. h. die Ladezeit war abgelaufen, WARP hat aber nicht abgeschaltet. Irgendwann blieben dann auch die Heartbeats aus, sodass eCarUp die Ladestation als nicht verfügbar klassifiziert hat. Nach einem Reboot wurde das zwischengespeicherte "StopTransaction"-Paket gesendet und anscheinend auch korrekt verarbeitet. Hier die zugehörigen Logs: 2022-10-31 15:31:14,379 Received message [3, "2780", {}] (len 15) 2022-10-31 15:31:14,380 Received StatusNotification.conf for connector 1 2022-10-31 15:31:14,391 Unexpected EVSEState 4 while Connector is in state 10 2022-10-31 15:31:14,475 Charger state changed from 3 to 1 2022-10-31 15:31:17,899 Sending Heartbeat.req. 165830587 165830587 165890587 60000 2022-10-31 15:32:17,120 Received message [2, "4da20005-6f14-60d0-8346-80e19ff359c (len 98) 2022-10-31 15:32:17,121 Received RemoteStopTransaction.req 2022-10-31 15:32:17,131 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:32:17,957 Sending Heartbeat.req. 165890645 165890645 165950645 60000 2022-10-31 15:33:17,839 Received message [2, "d6310005-8917-3663-f049-a04793fe7d6 (len 98) 2022-10-31 15:33:17,840 Received RemoteStopTransaction.req 2022-10-31 15:33:17,850 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:33:18,055 Sending Heartbeat.req. 165950743 165950743 166010743 60000 ... 2022-10-31 15:51:27,380 Received message [2, "f0b30005-7be3-e583-864f-8b3ac57c467 (len 98) 2022-10-31 15:51:27,381 Received RemoteStopTransaction.req 2022-10-31 15:51:27,391 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:52:19,001 Sending Heartbeat.req. 167091689 167091689 167151689 60000 2022-10-31 15:52:28,393 Received message [2, "513c0005-67d3-90e3-8940-83d0d39c212 (len 98) 2022-10-31 15:52:28,394 Received RemoteStopTransaction.req 2022-10-31 15:52:28,404 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:53:19,039 Sending Heartbeat.req. 167151727 167151727 167211727 60000 2022-10-31 15:53:28,409 Received message [2, "0c550005-22c8-66ea-e64c-b1b8f6dbf4e (len 98) 2022-10-31 15:53:28,410 Received RemoteStopTransaction.req 2022-10-31 15:53:28,420 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:54:19,103 Sending Heartbeat.req. 167211791 167211791 167271791 60000 2022-10-31 15:54:28,521 Received message [2, "ec750005-faf1-e631-7c45-86d5fd0bdc5 (len 98) 2022-10-31 15:54:28,522 Received RemoteStopTransaction.req 2022-10-31 15:54:28,532 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:55:10,168 FINISHING_UNLOCKED -> IDLE 2022-10-31 15:55:10,168 Sending StatusNotification.req: Status Available for connector 1 2022-10-31 15:55:10,960 Charger state changed from 1 to 0 2022-10-31 15:55:11,007 Tracked end of charge. 2022-10-31 15:55:19,202 Sending Heartbeat.req. 167271890 167271890 167331890 60000 2022-10-31 15:55:28,614 Received message [2, "907c0005-2321-be55-c047-90c97772a5a (len 98) 2022-10-31 15:55:28,614 Received RemoteStopTransaction.req 2022-10-31 15:55:28,625 Sending RemoteStopTransaction.conf Rejected (unknown connector id) 2022-10-31 15:56:19,219 Sending Heartbeat.req. 167331907 167331907 167391907 60000 2022-10-31 15:57:19,258 Sending Heartbeat.req. 167391947 167391947 167451947 60000 2022-10-31 15:58:19,317 Sending Heartbeat.req. 167452005 167452005 167512005 60000 2022-10-31 15:59:19,322 Sending Heartbeat.req. 167512010 167512010 167572010 60000 2022-10-31 16:00:19,407 Sending Heartbeat.req. 167572095 167572095 167632095 60000 2022-10-31 16:01:19,408 Sending Heartbeat.req. 167632096 167632096 167692096 60000 2022-10-31 16:02:19,432 Sending Heartbeat.req. 167692120 167692120 167752120 60000 2022-10-31 16:03:19,476 Sending Heartbeat.req. 167752165 167752165 167812165 60000 2022-10-31 16:04:19,490 Sending Heartbeat.req. 167812178 167812178 167872178 60000 2022-10-31 16:05:19,586 Sending Heartbeat.req. 167872274 167872274 167932274 60000 2022-10-31 16:06:19,602 Sending Heartbeat.req. 167932290 167932290 167992290 60000 2022-10-31 16:07:19,647 Sending Heartbeat.req. 167992336 167992336 168052336 60000 2022-10-31 16:08:19,743 Sending Heartbeat.req. 168052431 168052431 168112431 60000 2022-10-31 16:09:19,772 Sending Heartbeat.req. 168112460 168112460 168172460 60000 2022-10-31 16:10:19,847 Sending Heartbeat.req. 168172535 168172535 168232535 60000 2022-10-31 16:11:19,871 Sending Heartbeat.req. 168232559 168232559 168292559 60000 2022-10-31 16:12:19,912 Sending Heartbeat.req. 168292600 168292600 168352600 60000 2022-10-31 16:13:19,981 Sending Heartbeat.req. 168352669 168352669 168412669 60000 2022-10-31 16:14:20,023 Sending Heartbeat.req. 168412711 168412711 168472711 60000 8,375 Network connected. Stopping soft AP 8,404 MQTT: Connected to broker. 16,689 OCPP WEBSOCKET CONNECTED 16,776 Sending BootNotification.req. 16776 0 60000 60000 16,927 Received message [3, "1", {"status":"Accepted","currentTi (len 86) 16,928 Received BootNotification.conf for connector 0. Interval 60 2022-10-31 16:16:18,000 Sending StatusNotification.req: Status Available for charge point 2022-10-31 16:16:18,011 Sending StatusNotification.req: Status Available for connector 1 2022-10-31 16:16:18,055 Sending RESTORED StopTransaction.req for tag LNAL6KL446L2TFWMRGBQ at 725.466 kWh. Reason 11 2022-10-31 16:16:18,165 Received message [3, "4", {"idTagInfo":{"status":"Accepte (len 85) 2022-10-31 16:16:18,184 Received StopTransaction.conf for connector 0 2022-10-31 16:16:18,359 Received message [3, "2", {}] (len 12) 2022-10-31 16:16:18,360 Received StatusNotification.conf for connector 0 2022-10-31 16:16:18,562 Received message [3, "3", {}] (len 12) 2022-10-31 16:16:18,563 Received StatusNotification.conf for connector 1 2022-10-31 16:16:23,338 NTP synchronized at 21,511! 2022-10-31 16:17:08,316 This is warp2-XSS (warp2-XSS), a WARP2 Charger Pro 11kW 2022-10-31 16:17:18,630 Sending Heartbeat.req. 76803 76803 136803 60000 2022-10-31 16:17:18,730 Received message [3, "5", {"currentTime":"2022-10-31T15:1 (len 52) 2022-10-31 16:17:18,731 Received Heartbeat.conf for connector 0 2022-10-31 16:18:17,933 Sending Heartbeat.req. 136849 136849 196849 60000 2022-10-31 16:18:18,034 Received message [3, "6", {"currentTime":"2022-10-31T15:1 (len 52) 2022-10-31 16:18:18,035 Received Heartbeat.conf for connector 0 2022-10-31 16:19:17,977 Sending Heartbeat.req. 196939 196939 256939 60000 2022-10-31 16:19:18,070 Received message [3, "7", {"currentTime":"2022-10-31T15:1 (len 52) 2022-10-31 16:19:18,071 Received Heartbeat.conf for connector 0 Vielleicht helfen euch die Logs ja weiter. Falls hilfreich, so kann ich die Tests gerne auch nochmal mit deaktiviertem EVCC durchführen... Gruß Thomas