Wiederkehrende Ladeabbrüche mit openWBpro

[Jojo]

Liebes Forum,

seit dem Tag der Inbetriebnahme der openWBpro im Dezember 2021 kämpfe ich mit immer wiederkehrenden Ladeabbrüchen. Häufig finden Sie während einer Phasenumschaltung statt, manchmal - so auch heute wieder - mitten im Ladebetrieb (drei oder einphasig).


Systemkonfiguration:
openWB Version: 1.9.271
openWB Variante: openWBpro mit openWB Standalone (Display Version). Beide sind per Ethernet (Kabel) in das Netzwerk eingebunden.
PV Wechselrichter: E3DC
Fahrzeug: Porsche Taycan 4 CT, 2022

Ladeeinstellungen:
Lademodus: PV-Laden (automatische Phasenumschaltung aktiv)
Ladepunkt: LP1 (Garage)

Problembeschreibung:
Nicht nachvollziehbare Ladeabbrüche im regulären Ladebetrieb (egal ob 1- oder 3 Phasig), häufig auch während der Phasenumschaltung.

Hier bricht der Ladevorgang um 10:01 Uhr ab.

Im Debug-Log fällt immer die Meldung "2022-07-30 10:00:03: PID: 26054: **** FATAL Regulation loop needs 32 seconds (LV0)" auf, die finde ich allerdings auch an Stellen, an denen der Ladevorgang nicht abgebrochen wurde.

Code: Alles auswählen

2022-07-30 10:05:04: PID: 1148: ##### cron5min.sh finished ##### (LV0)
2022-07-30 10:05:01: PID: 1148: ##### cron5min.sh started ##### (LV0)
2022-07-30 10:01:03: PID: 640: **** FATAL ********************************* (LV0)
2022-07-30 10:01:03: PID: 640: **** FATAL Regulation loop needs 32 seconds (LV0)
OK Value:3 accepted2022-07-30 10:01:03: PID: 640: **** FATAL ********************************* (LV0)
2022-07-30 10:00:04: PID: 29380: ##### cron5min.sh finished ##### (LV0)
2022-07-30 10:00:03: PID: 26054: **** FATAL ********************************* (LV0)
2022-07-30 10:00:03: PID: 26054: **** FATAL Regulation loop needs 32 seconds (LV0)
2022-07-30 10:00:03: PID: 26054: **** FATAL ********************************* (LV0)
OK Value:1 accepted2022-07-30 10:00:01: PID: 29380: ##### cron5min.sh started ##### (LV0)
2022-07-30 09:55:04: PID: 24665: ##### cron5min.sh finished ##### (LV0)

Das Log der openWBpro zeigt für den betreffenden Zeitraum (Die openWBpro Systemzeit hat einen Zeit-Offset von -2 Stunden relativ zur Sommerzeit) folgende Einträge:

Code: Alles auswählen

Jul 30 07:54:46 openWBPro-386964 pwmd[267]: [07:54:46.846] [INFO] changed CP enable 1, duty cycle 11.660 %
Jul 30 07:55:36 openWBPro-386964 iec61851d[252]: [07:55:36.470] [INFO] main loop: setting new duty cycle 10.000%
Jul 30 07:55:36 openWBPro-386964 pwmd[267]: [07:55:36.488] [INFO] changed CP enable 1, duty cycle 10.000 %
Jul 30 07:56:05 openWBPro-386964 iec61851d[252]: [07:56:05.643] [INFO] main loop: setting new duty cycle 11.667%
Jul 30 07:56:05 openWBPro-386964 pwmd[267]: [07:56:05.648] [INFO] changed CP enable 1, duty cycle 11.660 %
Jul 30 07:56:58 openWBPro-386964 iec61851d[252]: [07:56:58.167] [INFO] main loop: setting new duty cycle 10.000%
Jul 30 07:56:58 openWBPro-386964 pwmd[267]: [07:56:58.183] [INFO] changed CP enable 1, duty cycle 10.000 %
Jul 30 07:57:06 openWBPro-386964 iec61851d[252]: [07:57:06.953] [INFO] main loop: setting new duty cycle 11.667%
Jul 30 07:57:06 openWBPro-386964 pwmd[267]: [07:57:06.965] [INFO] changed CP enable 1, duty cycle 11.660 %
Jul 30 07:57:15 openWBPro-386964 iec61851d[252]: [07:57:15.751] [INFO] main loop: setting new duty cycle 10.000%
Jul 30 07:57:15 openWBPro-386964 pwmd[267]: [07:57:15.760] [INFO] changed CP enable 1, duty cycle 10.000 %
Jul 30 07:57:27 openWBPro-386964 iec61851d[252]: [07:57:27.421] [INFO] main loop: setting new duty cycle 11.667%
Jul 30 07:57:27 openWBPro-386964 pwmd[267]: [07:57:27.428] [INFO] changed CP enable 1, duty cycle 11.660 %
Jul 30 07:58:08 openWBPro-386964 pwmd[267]: [07:58:08.266] [INFO] changed CP enable 1, duty cycle 13.330 %
Jul 30 07:58:08 openWBPro-386964 iec61851d[252]: [07:58:08.262] [INFO] main loop: setting new duty cycle 13.333%
Jul 30 07:58:17 openWBPro-386964 iec61851d[252]: [07:58:17.041] [INFO] main loop: setting new duty cycle 10.000%
Jul 30 07:58:17 openWBPro-386964 pwmd[267]: [07:58:17.047] [INFO] changed CP enable 1, duty cycle 10.000 %
Jul 30 07:58:46 openWBPro-386964 iec61851d[252]: [07:58:46.281] [INFO] main loop: setting new duty cycle 13.333%
Jul 30 07:58:46 openWBPro-386964 pwmd[267]: [07:58:46.291] [INFO] changed CP enable 1, duty cycle 13.330 %
Jul 30 07:58:57 openWBPro-386964 iec61851d[252]: [07:58:57.938] [INFO] main loop: setting new duty cycle 18.333%
Jul 30 07:58:57 openWBPro-386964 pwmd[267]: [07:58:57.943] [INFO] changed CP enable 1, duty cycle 18.330 %
Jul 30 07:59:44 openWBPro-386964 iec61851d[252]: [07:59:44.799] [INFO] New phase target: 1
Jul 30 07:59:44 openWBPro-386964 iec61851d[252]: [07:59:44.802] [INFO] main loop: setting new duty cycle 100.000% PAUSE
Jul 30 07:59:44 openWBPro-386964 pwmd[267]: [07:59:44.807] [INFO] changed CP enable 1, duty cycle 100.000 %
Jul 30 07:59:45 openWBPro-386964 iec61851d[252]: [07:59:45.949] [INFO] main loop: open contactor
Jul 30 07:59:45 openWBPro-386964 pwmd[267]: [07:59:45.954] [INFO] main loop: set new CP state: B (CP (+) 8861 (-) 132 mV)
Jul 30 07:59:46 openWBPro-386964 iec61851d[252]: [07:59:46.055] [INFO] Apply phase target: 1
Jul 30 07:59:46 openWBPro-386964 iec61851d[252]: [07:59:46.056] [INFO] IEC_STATE_CONTACTOR_OPEN_LOCK_CLOSE
Jul 30 07:59:55 openWBPro-386964 iec61851d[252]: [07:59:55.958] [INFO] Switch delay (10000 ms) expired
Jul 30 07:59:55 openWBPro-386964 iec61851d[252]: [07:59:55.978] [INFO] main loop: setting new duty cycle 18.333%
Jul 30 07:59:55 openWBPro-386964 pwmd[267]: [07:59:55.987] [INFO] changed CP enable 1, duty cycle 18.330 %
Jul 30 08:00:05 openWBPro-386964 iec61851d[252]: [08:00:05.201] [INFO] main loop: setting new duty cycle 10.000%
Jul 30 08:00:05 openWBPro-386964 pwmd[267]: [08:00:05.211] [INFO] changed CP enable 1, duty cycle 10.000 %
Jul 30 08:00:43 openWBPro-386964 iec61851d[252]: [08:00:43.179] [INFO] New phase target: 3
Jul 30 08:09:40 openWBPro-386964 iec61851d[252]: [08:09:40.115] [INFO] main loop: close contactor

Um 10:09 startete der Ladevorgang (PV-Laden) dann wieder ohne mein Zutun. Das ist aber nicht immer der Fall. Der openWB Service ist freundlich und bemüht, konnte mir bisher aber nicht weiterhelfen.

Da ich mich so nicht auf das System verlassen kann, ist das ein sehr unbefriedigender Zustand. Ich würde mich sehr über Hinweise und Tipps freuen.

Vielen Dank und viele Grüße
Jo

[openWB]

Der Taycan ist leider nicht unproblematisch.
Porsche weiß grundsätzlich Bescheid. Zunächst prüfen ob die aktuellste Firmware dort installiert ist.
Gerade in Kombination mit der Umschaltung muss schlicht Porsche hier nachbessern.

[Jojo]

Hallo openWB-Team,

vielen Dank für die Nachricht. Dass der Taycan Probleme mit der Phasenumschaltung hat kann ich nicht bestätigen. Taycan Fahrer mit anderen Ladesystemen (SMA, Fronius) berichten über einen reibungslosen Betrieb auch mit Phasenumschaltung. Ich werde mich hier trotzdem nochmal informieren, danke für den Hinweis.

Bei mir scheint es so, als würde das System unnötigerweise eine Phasenumschaltung durchführen und dabei wird der Ladevorgang sporadisch unterbrochen, wie im oben geloggten Beispiel.

Heute Vormittag konnte ich das Phänomen gleich nochmal beobachten, dieses Mal wurde der Ladevorgang im Gegensatz zum ersten Fall aber einphasig weitergeführt. Die Umschaltung an sich war aber ungerechtfertigt. Der kurze Peak im Hausverbrauch muss eine fehlerhafte Berechnung in Folge der Umschaltung selbst sein, denn zu diesem Zeitpunkt liefen im Haus keine großen Verbraucher.

Gibt es noch mehr Ideen dazu?

Danke und viele Grüße
Jo

[derNeueDet]

Solche Peaks kommen zustande, wenn die Werte nicht zeitgleich ermittelt werden. Der Hausverbrauch ist nicht gemessen sondern berechnet. Wie werden EVU und PV Daten ermittelt? Also welche Module werden da verwendet?

[Jojo]

Solche Peaks kommen zustande, wenn die Werte nicht zeitgleich ermittelt werden. Der Hausverbrauch ist nicht gemessen sondern berechnet. Wie werden EVU und PV Daten ermittelt? Also welche Module werden da verwendet?

Danke, so habe ich mir die Peaks auch erklärt. Ich halte den Peak aber für eine Folge des Ladeabbruchs und nicht andersherum. Die Werte stammen alle aus dem E3DC-Modul und werden daher per Modbus eingelesen, soweit ich weiß.

[derNeueDet]

Das Thema können die verlängerten Regel Zyklen sein. Wenn hier regelmäßig über die 10 Sekunden raus gegangen wird, dann wäre das ein Problem. Hier laufen dann ja mehrere Regel Prozesse gleichzeitig.

[Jojo]

Das Thema können die verlängerten Regel Zyklen sein. Wenn hier regelmäßig über die 10 Sekunden raus gegangen wird, dann wäre das ein Problem. Hier laufen dann ja mehrere Regel Prozesse gleichzeitig.

Da bei jedem von mir beobachteten Abbruch eine Logeintrag über ein verlängertes Regelintervall eingetragen wird, vermute ich auch dass es damit zu tun hat. Die Frage wäre jetzt, warum die verlängerten Regelintervalle auftreten und was man dagegen tun kann.

[derNeueDet]

Dazu sind deine bisherigen Log Ausschnitte zu wenig würde ich sagen.
Stelle mal das Debugging auf 2 und lass die Box eine Zeit lang laufen. Dann evtl. Einen Teil hier Posten, wenn du wieder einen Fatal findest.

Gibt es noch irgendwelche Smarthome Systeme, die auf die openWB zugreifen? Hast du das openWB eigene Smarthome aktiv? Wenn ja, welche Komponenten steuerst du an?

VG
Det

[Jojo]

Danke für den Hinweis, ich logge den nächsten Ladevorgang mit der höchsten Detailstufe. Die openWB steuert keine SH-Geräte an. Auf dem Modbus sendet sonst noch eine Wärmepumpe, ein RasPi mit Homeassistent liest bisher nur mit.

[aiole]

Poste bitte auch mal einen screenshot des lokalen Pro-GUI, wo man den Softwarestand erkennen kann. Ev. muss die Firmware upgedatet werden.