Fehlermeldung PV-Modul von openWB

[michaelof]

Der Thread-Ersteller "Peter" schreibt im allerersten Post vom 8. Juni 22:

"... und habe seit einigen Tagen eine openWB Wallbox Standard + laufen mit EVU und PV Modul (ebenfalls von openWB)."

Ich selbst habe am 8. Juni 22 bestellt und superschnell am 9. Juni über den openWB Shop ein PV-Kit und ein EVU-Kit geliefert bekommen.
Daher gehe ich mal stark davon aus, dass "Peter" und ich exakt die gleichen Kits geliefert bekommen haben und nutzen.

Zu den letzten Fragen: Jedes Kit hat einen eigenen PE11.Der PE11 des PV-Kits ist OOTB mit statischer IPv4 auf 192.168.193.13 konfiguriert. Der PE11 des EVU-Kits auf 192.168.193.15. Und die owb selbst auf 192.168.193.5.

"VERBUNDEN" sind also tatsächlich nur Verbindungen zum PE11 des PV-Kits auf der 15, alle Verbindungen zum EVI-Kit (auf der 13) sind im Status "TIME_WAIT" und damit zu.

Code: Alles auswählen

$ sudo  netstat -nap | grep 192.168.193 | sort -k5
udp        0      0 192.168.193.5:137       0.0.0.0:*                           1745/nmbd           
udp        0      0 192.168.193.5:138       0.0.0.0:*                           1745/nmbd           
udp        0      0 192.168.193.255:137     0.0.0.0:*                           1745/nmbd           
udp        0      0 192.168.193.255:138     0.0.0.0:*                           1745/nmbd           
tcp        0      0 192.168.193.5:32975     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:36275     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:40143     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:40881     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:48363     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:49589     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:50581     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:56639     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:57859     192.168.193.13:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:40949     192.168.193.13:8899     VERBUNDEN   2571/python3        
tcp        0      0 192.168.193.5:42081     192.168.193.13:8899     VERBUNDEN   2571/python3        
tcp        0      0 192.168.193.5:50683     192.168.193.13:8899     VERBUNDEN   2571/python3        
tcp        0      0 192.168.193.5:59049     192.168.193.13:8899     VERBUNDEN   2571/python3        
tcp        0      0 192.168.193.5:42043     192.168.193.15:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:44513     192.168.193.15:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:45223     192.168.193.15:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:46629     192.168.193.15:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:53189     192.168.193.15:8899     TIME_WAIT   -                   
tcp        0      0 192.168.193.5:58547     192.168.193.15:8899     TIME_WAIT   -            

[derNeueDet]

Welche Version der openWB Software läuft bei dir (Einstellungen/System/Systeminfo)? Kannst du mal die Konfigurationsseite deiner PV Konfig zeigen?

Und ihr seid nicht die Einzigen bei denen es Probleme mit dem PV Kit gibt

viewtopic.php?p=66700#p66700

VG
Det

[michaelof]

Systeminfo:

PV-Konfig:

PV-Status:

[michaelof]

Und ihr seid nicht die Einzigen bei denen es Probleme mit dem PV Kit gibt
viewtopic.php?p=66700#p66700

VG
Det

Stimmt, sieht sehr nach unserem Fehler aus. Ich verlinke mal in die andere Richtung....

[derNeueDet]

Geh mal auf die aktuelle Nightly und schaue, ob der Fehler da auch auftaucht.

Läuft noch was anderes auf dem Pi? Von 16GB nur noch 2,5GB frei ist nicht normal.

VG
Det

[michaelof]

Geh mal auf die aktuelle Nightly und schaue, ob der Fehler da auch auftaucht.

Mache ich, sobald die Sonne untergeht, damit die die heutige PV-Statistik weiterhin stimmt

Läuft noch was anderes auf dem Pi? Von 16GB nur noch 2,5GB frei ist nicht normal.

Ja, klar Ist der alte Rasppi 3 unseres dreizehnjährigen Sohnes, vor seinem jetzigen 4. Einige Altlasten drauf.
Ich hätte noch einen "leeren" Rasppi 2, gibt es einen technischen Grund, warum 3 als Hardware Req. genannt wird? RAM ist bei beiden 1GB, CPU Takt mit 1200 statt 900 Mhz beim 3 etwas höher.

[derNeueDet]

... Einige Altlasten drauf...

Nicht unbedingt das was ich hören wollte. Wie gesagt, bei mir scheint es mit der aktuellen Nightly zu funktionieren. Gut wenn es bei dir dann auch so ist nach dem Update, aber wenn nicht, solltest du dir mal überlegen, den Raspi mit einem sauberen Buster neu zu installieren, um sicher zu gehen, dass die Altlasten nicht mit Seiteneffekten hier rein fummeln.

VG
Det

[michaelof]

Nightly 1.9.272 ist drauf, Fehler unverändert.

Ich glaube nicht, dass die "Altlasten" auf meinem Pi eine Relevanz haben, sind viele Daten (Fotos, Videos, LibreOffice, Minecraft-Welten ..), keine Software-Pakete, die stören sollten. Ich werde trotzdem demnächst eine zweite SD besorgen und leer aufsetzen. Ist übrigens noch Raspbian Stretch, kein Buster, das aber immer auf dem neuesten Stand. Laut https://github.com/snaptec/openWB#readme auch "bevorzugt".

Viel relevanter finde ich persönlich aber, dass der Fehler exakt so beim Thread-Ersteller "Peter" mit gekaufter openWB standalone auch auftritt, ohne jegliche "Altlasten".

Vielleicht hilft der hier im Thread gefundene Hinweis mit den offen gelassenen Verbindungen zum PE11 des PV-Kits ja, dass der Fehler bald gefixt werden kann.

[pautz@t-online.de]

Hallo zusammen,

ich habe dazu ein Debug-Request bei openWB gestellt und man will sich das per Cloud Debug ansehen. Bisher keine neuen Erkenntnisse .

Im Debuglog kommt sporadisch immer noch diese Fehlermeldung, ich kann aber nicht sagen ob dies "irgendetwas" macht. Ich habe bisher keine Funktionsbeeinträchtigung festgestellt, welche ich hiermit in Verbindung bringen würde.

Code: Alles auswählen

modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 8 bytes (0 received)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
str(e)) from e
File "/var/www/html/openWB/packages/modules/common/modbus.py", line 105, in __read_registers
return self.__read_registers(self.delegate.read_input_registers, address, types, byteorder, wordorder, **kwargs)
File "/var/www/html/openWB/packages/modules/common/modbus.py", line 142, in read_input_registers
powers = self.client.read_input_registers(0x0C, [ModbusDataType.FLOAT_32]*3, unit=self.id)
File "/var/www/html/openWB/packages/modules/common/sdm.py", line 60, in get_power
self.process_error(e)
File "/var/www/html/openWB/packages/modules/common/sdm.py", line 64, in get_power
powers, power = self.__client.get_power()
File "/var/www/html/openWB/packages/modules/openwb_flex/inverter.py", line 41, in update
self._components[component].update()
File "/var/www/html/openWB/packages/modules/openwb_pv_kit/device.py", line 42, in update
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 8 bytes (0 received)', <FaultStateLevel.ERROR: 2>)
raise FaultState.error(__name__+" "+str(response))
File "/var/www/html/openWB/packages/modules/common/modbus.py", line 89, in __read_registers
Traceback (most recent call last):
2022-06-16 04:40:35: PID: 2174: soc.modules.common.fault_state: PV-Kit: FaultState FaultStateLevel.ERROR, FaultStr modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 8 bytes (0 received)', <FaultStateLevel.ERROR: 2>), Traceback:

Neu für mich ist diese sporadisch auftretende Meldung im Debuglog:

Code: Alles auswählen

2022-06-16 09:30:03: PID: 6995: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:30:01: PID: 6995: ##### cron5min.sh started ##### (LV0)
2022-06-16 09:27:23: PID: 20331: Modbus EVSE read CP1 issue - using previous state '1' (LV0)
2022-06-16 09:25:04: PID: 3437: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:25:01: PID: 3437: ##### cron5min.sh started ##### (LV0)
2022-06-16 09:20:04: PID: 32203: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:20:01: PID: 32203: ##### cron5min.sh started ##### (LV0)
2022-06-16 09:15:04: PID: 28588: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:15:02: PID: 28588: ##### cron5min.sh started ##### (LV0)
2022-06-16 09:10:04: PID: 25005: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:10:01: PID: 25005: ##### cron5min.sh started ##### (LV0)
2022-06-16 09:05:04: PID: 21398: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:05:01: PID: 21398: ##### cron5min.sh started ##### (LV0)
2022-06-16 09:01:13: PID: 26405: Modbus EVSE read CP1 issue - using previous state '1' (LV0)
2022-06-16 09:00:03: PID: 17795: ##### cron5min.sh finished ##### (LV0)
2022-06-16 09:00:01: PID: 17795: ##### cron5min.sh started ##### (LV0)
2022-06-16 08:55:03: PID: 14240: ##### cron5min.sh finished ##### (LV0)
2022-06-16 08:55:01: PID: 14240: ##### cron5min.sh started ##### (LV0)
2022-06-16 08:50:03: PID: 10671: ##### cron5min.sh finished ##### (LV0)
2022-06-16 08:50:01: PID: 10671: ##### cron5min.sh started ##### (LV0)
2022-06-16 08:45:23: PID: 9757: Modbus EVSE read CP1 issue - using previous state '1' (LV0)
2022-06-16 08:45:03: PID: 7103: ##### cron5min.sh finished ##### (LV0)
2022-06-16 08:45:01: PID: 7103: ##### cron5min.sh started ##### (LV0)

Kann jemand sagen, was dies bedeutet und ob es ein Fehler ist?

Danke und Gruß

Peter

[LenaK]

Der Bug sollte in der aktuellen Nightly behoben sein.