Seite 3 von 6

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 8:24 am
von LenaK
@all Bei Problemen und Modulfehlern bitte das Debuglevel auf 2 stellen und mind. den Durchlauf einer Regelschleife aus dem Debuglog posten. Evtl. enthaltene Anmeldedaten bitte vorher unkenntlich machen.

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 8:41 am
von Andyme
Anbei mein Debug Log:

Code: Alles auswählen

2022-06-23 10:35:00: PID: 20591: soc.modules.common.component_context: Update Komponente ['Huawei Speicher']
2022-06-23 10:35:00: PID: 20591: modules.huawei.device: Start device reading {'componentbat': <modules.huawei.bat.HuaweiBat object at 0x751c3cd0>, 'componentinverter': <modules.huawei.inverter.HuaweiInverter object at 0x75646470>, 'componentcounter': <modules.huawei.counter.HuaweiCounter object at 0x756272d0>}
2022-06-23 10:35:00: PID: 20591: modules.huawei.device: Huawei Modbus-ID: 1
2022-06-23 10:35:00: PID: 20591: modules.huawei.device: Huawei IP-Adresse: 192.168.1.32
2022-06-23 10:34:53: PID: 20591: modules.huawei.device: components to read: ['inverter', 'counter', 'bat']
2022-06-23 10:34:53: PID: 20591: legacy run server: Received command ["modules.huawei.device","192.168.1.32","1","True","True"]
2022-06-23 10:34:45: PID: 20591: legacy run server: Completed running command in 0.58s: ["modules.json.device","inverter","http://192.168.5.220/status",".emeters[0].power+.emeters[1].power

AttributeError: 'NoneType' object has no attribute 'encode'
File "jq.pyx", line 113, in jq.compile
exported = jq.compile(config["jq_exported"]).input(response).first()
File "/var/www/html/openWB/packages/modules/json/inverter.py", line 46, in update
self.components[component].update(response.json())
File "/var/www/html/openWB/packages/modules/json/device.py", line 104, in update
Traceback (most recent call last):
2022-06-23 10:34:45: PID: 20591: soc.modules.common.fault_state: Json Wechselrichter: FaultState FaultStateLevel.ERROR, FaultStr <class 'AttributeError'> 'NoneType' object has no attribute 'encode', Traceback:
2022-06-23 10:34:45: PID: 20591: soc.modules.common.req: Get-Response: {"wifi_sta":{"connected":true,"ssid":"wireless-iot","ip":"192.168.5.220","rssi":-47},"cloud":{"enabled":true,"connected":true},"mqtt":{"connected":false},"time":"10:34","unixtime":1655973285,"serial":45174,"has_update":false,"mac":"40F52000E714","cfg_changed_cnt":1,"actions_stats":{"skipped":0},"relays":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"overpower":false,"is_valid":true,"source":"input"}],"emeters":[{"power":-456.15,"pf":-0.99,"current":1.98,"voltage":232.29,"is_valid":true,"total":6760.2,"total_returned":4028615.8},{"power":-460.90,"pf":-0.99,"current":1.99,"voltage":232.96,"is_valid":true,"total":3739.3,"total_returned":4035850.6},{"power":-459.15,"pf":-0.99,"current":1.98,"voltage":233.49,"is_valid":true,"total":1843.8,"total_returned":4028817.0}],"total_power":-1376.20,"fs_mounted":true,"update":{"status":"idle","has_update":false,"new_version":"20220324-123835/v1.11.8-3EM-fix-g0014dcb","old_version":"20220324-123835/v1.11.8-3EM-fix-g0014dcb"},"ram_total":49440,"ram_free":31116,"fs_size":233681,"fs_free":154867,"uptime":4823891}
2022-06-23 10:34:45: PID: 20591: requests.packages.urllib3.connectionpool: http://192.168.5.220:80 "GET /status HTTP/1.1" 200 1104
2022-06-23 10:34:45: PID: 20591: requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): 192.168.5.220:80
2022-06-23 10:34:45: PID: 20591: soc.modules.common.component_context: Update Komponenten ['Json Wechselrichter']
2022-06-23 10:34:45: PID: 20591: modules.json.device: Start device reading {'component2': <modules.json.inverter.JsonInverter object at 0x752bb8d0>}
2022-06-23 10:34:45: PID: 20591: legacy run server: Log level changed WARNING -> DEBUG

AttributeError: 'NoneType' object has no attribute 'encode'
File "jq.pyx", line 113, in jq.compile
exported = jq.compile(config["jq_exported"]).input(response).first()
File "/var/www/html/openWB/packages/modules/json/inverter.py", line 46, in update
self.components[component].update(response.json())
File "/var/www/html/openWB/packages/modules/json/device.py", line 104, in update
Traceback (most recent call last):
2022-06-23 10:34:25: PID: 20591: soc.modules.common.fault_state: Json Wechselrichter: FaultState FaultStateLevel.ERROR, FaultStr <class 'AttributeError'> 'NoneType' object has no attribute 'encode', Traceback:

AttributeError: 'NoneType' object has no attribute 'encode'
File "jq.pyx", line 113, in jq.compile
exported = jq.compile(config["jq_exported"]).input(response).first()
File "/var/www/html/openWB/packages/modules/json/inverter.py", line 46, in update
self.components[component].update(response.json())
File "/var/www/html/openWB/packages/modules/json/device.py", line 104, in update
Traceback (most recent call last):
2022-06-23 10:34:06: PID: 20591: soc.modules.common.fault_state: Json Wechselrichter: FaultState FaultStateLevel.ERROR, FaultStr <class 'AttributeError'> 'NoneType' object has no attribute 'encode', Traceback:

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 9:27 am
von LenaK
LarsBr87 hat geschrieben: Mi Jun 15, 2022 6:48 am Hallo,

habe gestern ein Update von der letzten stable auf dieses hier durchgeführt und soweit hat auch alles gut geklappt (beide Boxen wurden geupdated) nur leider läuft das PV Kit aus dem Shop nicht mehr. Er zeigt folgendem Fehler unter Status an:

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_flex/device.py", line 60, 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-15 08:51:15: PID: 10523: soc.modules.common.fault_state: PV-Kit flex: 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:
2022-06-15 08:51:10: PID: 861: **** FATAL ********************************* (LV0)
2022-06-15 08:51:10: PID: 861: **** FATAL Regulation loop needs 10 seconds (LV0)
2022-06-15 08:51:10: PID: 861: **** FATAL ********************************* (LV0)

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_flex/device.py", line 60, in update
Traceback (most recent call last):

The above exception was the direct cause of the following exception:
Der Bug sollte in der aktuellen Nightly behoben sein.

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 9:39 am
von LenaK
Andyme hat geschrieben: Do Jun 23, 2022 8:41 am Anbei mein Debug Log:

Code: Alles auswählen

2022-06-23 10:35:00: PID: 20591: soc.modules.common.component_context: Update Komponente ['Huawei Speicher']
2022-06-23 10:35:00: PID: 20591: modules.huawei.device: Start device reading {'componentbat': <modules.huawei.bat.HuaweiBat object at 0x751c3cd0>, 'componentinverter': <modules.huawei.inverter.HuaweiInverter object at 0x75646470>, 'componentcounter': <modules.huawei.counter.HuaweiCounter object at 0x756272d0>}
2022-06-23 10:35:00: PID: 20591: modules.huawei.device: Huawei Modbus-ID: 1
2022-06-23 10:35:00: PID: 20591: modules.huawei.device: Huawei IP-Adresse: 192.168.1.32
2022-06-23 10:34:53: PID: 20591: modules.huawei.device: components to read: ['inverter', 'counter', 'bat']
2022-06-23 10:34:53: PID: 20591: legacy run server: Received command ["modules.huawei.device","192.168.1.32","1","True","True"]
2022-06-23 10:34:45: PID: 20591: legacy run server: Completed running command in 0.58s: ["modules.json.device","inverter","http://192.168.5.220/status",".emeters[0].power+.emeters[1].power

AttributeError: 'NoneType' object has no attribute 'encode'
File "jq.pyx", line 113, in jq.compile
exported = jq.compile(config["jq_exported"]).input(response).first()
File "/var/www/html/openWB/packages/modules/json/inverter.py", line 46, in update
self.components[component].update(response.json())
File "/var/www/html/openWB/packages/modules/json/device.py", line 104, in update
Traceback (most recent call last):
2022-06-23 10:34:45: PID: 20591: soc.modules.common.fault_state: Json Wechselrichter: FaultState FaultStateLevel.ERROR, FaultStr <class 'AttributeError'> 'NoneType' object has no attribute 'encode', Traceback:
2022-06-23 10:34:45: PID: 20591: soc.modules.common.req: Get-Response: {"wifi_sta":{"connected":true,"ssid":"wireless-iot","ip":"192.168.5.220","rssi":-47},"cloud":{"enabled":true,"connected":true},"mqtt":{"connected":false},"time":"10:34","unixtime":1655973285,"serial":45174,"has_update":false,"mac":"40F52000E714","cfg_changed_cnt":1,"actions_stats":{"skipped":0},"relays":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"overpower":false,"is_valid":true,"source":"input"}],"emeters":[{"power":-456.15,"pf":-0.99,"current":1.98,"voltage":232.29,"is_valid":true,"total":6760.2,"total_returned":4028615.8},{"power":-460.90,"pf":-0.99,"current":1.99,"voltage":232.96,"is_valid":true,"total":3739.3,"total_returned":4035850.6},{"power":-459.15,"pf":-0.99,"current":1.98,"voltage":233.49,"is_valid":true,"total":1843.8,"total_returned":4028817.0}],"total_power":-1376.20,"fs_mounted":true,"update":{"status":"idle","has_update":false,"new_version":"20220324-123835/v1.11.8-3EM-fix-g0014dcb","old_version":"20220324-123835/v1.11.8-3EM-fix-g0014dcb"},"ram_total":49440,"ram_free":31116,"fs_size":233681,"fs_free":154867,"uptime":4823891}
2022-06-23 10:34:45: PID: 20591: requests.packages.urllib3.connectionpool: http://192.168.5.220:80 "GET /status HTTP/1.1" 200 1104
2022-06-23 10:34:45: PID: 20591: requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): 192.168.5.220:80
2022-06-23 10:34:45: PID: 20591: soc.modules.common.component_context: Update Komponenten ['Json Wechselrichter']
2022-06-23 10:34:45: PID: 20591: modules.json.device: Start device reading {'component2': <modules.json.inverter.JsonInverter object at 0x752bb8d0>}
2022-06-23 10:34:45: PID: 20591: legacy run server: Log level changed WARNING -> DEBUG

AttributeError: 'NoneType' object has no attribute 'encode'
File "jq.pyx", line 113, in jq.compile
exported = jq.compile(config["jq_exported"]).input(response).first()
File "/var/www/html/openWB/packages/modules/json/inverter.py", line 46, in update
self.components[component].update(response.json())
File "/var/www/html/openWB/packages/modules/json/device.py", line 104, in update
Traceback (most recent call last):
2022-06-23 10:34:25: PID: 20591: soc.modules.common.fault_state: Json Wechselrichter: FaultState FaultStateLevel.ERROR, FaultStr <class 'AttributeError'> 'NoneType' object has no attribute 'encode', Traceback:

AttributeError: 'NoneType' object has no attribute 'encode'
File "jq.pyx", line 113, in jq.compile
exported = jq.compile(config["jq_exported"]).input(response).first()
File "/var/www/html/openWB/packages/modules/json/inverter.py", line 46, in update
self.components[component].update(response.json())
File "/var/www/html/openWB/packages/modules/json/device.py", line 104, in update
Traceback (most recent call last):
2022-06-23 10:34:06: PID: 20591: soc.modules.common.fault_state: Json Wechselrichter: FaultState FaultStateLevel.ERROR, FaultStr <class 'AttributeError'> 'NoneType' object has no attribute 'encode', Traceback:
Von welcher Version kommst Du denn? Ich vermute, dass die Addition der Leistungen nicht funktioniert. Python sucht nach einem Eintrag namens "power+".
Funktioniert es, wenn Du als json-Ausdruck für die Leistung "total_power" eingibst?

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 11:30 am
von Andyme
Ich war schon auf der Nightly von ca. 8 Tagen, da hat alles noch funktioniert. Mit der aktuellen nightly "installierte Version: 1.9.272 (2022-06-22 16:59:20 +0200 [c9c5756a] )" habe ich jetzt den Fehler. Das mit "total_power" hat nicht funktioniert.

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 1:16 pm
von LenaK
Andyme hat geschrieben: Do Jun 23, 2022 11:30 am Ich war schon auf der Nightly von ca. 8 Tagen, da hat alles noch funktioniert. Mit der aktuellen nightly "installierte Version: 1.9.272 (2022-06-22 16:59:20 +0200 [c9c5756a] )" habe ich jetzt den Fehler. Das mit "total_power" hat nicht funktioniert.
Ist in der Nightly gefixt. Bitte nochmal ein Backup und dann ein Update machen.

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 1:26 pm
von Andyme
Top Arbeit. Besten Dank. Jetzt funktionierts wieder.

Re: Rückmeldungen Stable 1.9.271

Verfasst: Do Jun 23, 2022 7:44 pm
von Klaggo
openWB hat geschrieben: Mi Jun 22, 2022 7:31 pm Was ist denn als PV Modul konfiguriert?
Das war es! Ich hatte AlphaESS nur bei EVU und bei PV war nichts eingetragen (hatte vorher so aber funktioniert). Jetzt habe ich bei PV AlphaESS-Speicher eintragen und es funktioniert wieder alles. Danke für die Hilfe!

Re: Rückmeldungen Stable 1.9.271

Verfasst: Fr Jun 24, 2022 10:29 am
von pc1246
Moin
Bei mir hat sich irgendetwas aufgehaengt!
2022-06-24 12_15_36-openWB — Mozilla Firefox (Private Browsing).png
openWB denkt es wird mit 2,1 kW geladen. Das EV ist aber gar nicht mehr an der Box.
Zudem blinkt die 30A Meldung, obwohl eigentlich gar nicht "Min + PV" eingestellt ist.
Eigentlich deshalb, weil die Box das gerne von alleine einstellt, vorhin z.B. nach einem Neustart.
Wie bekomme ich die Box jetzt wieder in den Normalzustand? Ein harter reboot, da das interne Display weg war, und ein Softreboot per Weboberflaeche hat nichts veraendert.

Edit: Kann ich trotzdem laden, solange der Zustand so komisch ist?

Gruss Christoph

Unten schon mal ein Debugauszug.
Wenn noch mehr gebraucht wird, gerne melden.

Code: Alles auswählen

2022-06-24 12:22:38: PID: 19191: **** Regulation loop needs 7 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
set-currents: setze ladung auf 30A
2022-06-24 12:22:37: PID: 19191: uberschuss 0 wattbezug 0 ladestatus 1 llsoll 0 pvwatt -1818 mindestuberschussphasen 1500 wattkombiniert 0 schaltschwelle 230 (LV2) at 576 main /var/www/html/openWB/regel.sh
2022-06-24 12:22:37: PID: 19191: anzahlphasen 1 (LV1) at 575 main /var/www/html/openWB/regel.sh
2022-06-24 12:22:36: PID: 19191: Timing Umschaltung: 480 / 480 (LV1) at 15 u1p3pswitch u1p3p.sh
2022-06-24 12:22:36: PID: 19191: automatische Umschaltung aktiv (LV1) at 14 u1p3pswitch u1p3p.sh
2022-06-24 12:22:36: PID: 19191: Zeit zum abfragen aller Werte 4 Sekunden (LV1) at 176 main /var/www/html/openWB/regel.sh
2022-06-24 12:22:35: PID: 19191: chargestatlp1 0	chargestatlp2 0	chargestatlp3 0 (LV1) at 1305 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: plugstatlp1 0	plugstatlp2 0	plugstatlp3 0 (LV1) at 1304 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: lp1enabled 0	lp2enabled 1	lp3enabled 1 (LV1) at 1303 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: EVU 1:V/0A 2: V/0A 3: V/0A (LV1) at 1302 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: lla3 0	llv3 234.5	llas13  llas23  soclp1 0 soclp2 (LV1) at 1301 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: lla2 0	llv2 236.2	llas12  llas22  sofortll 16 hausverbrauch 31 wattbezug 0 uberschuss 0 (LV1) at 1300 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: lla1 0	llv1 236.9	llas11  llas21  mindestuberschuss 1500 abschaltuberschuss 5 lademodus 2 (LV1) at 1299 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: pv1watt -1818 pv2watt  pvwatt -1818 ladeleistung 0 llalt 0 nachtladen 1 nachtladen 0 minimalA 10 maximalA 16 (LV1) at 1298 loadvars loadvars.sh
2022-06-24 12:22:35: PID: 19191: speicherleistung 1115 speichersoc 55 (LV1) at 1293 loadvars loadvars.sh
2022-06-24 12:22:34: PID: 19385: RET: 0 (LV2) at 16 main modules/bezug_kostalplenticoreem300haus/main.sh
2022-06-24 12:22:34: PID: 2405: legacy run server: Completed running command in 0.01s: ["bezug_kostalplenticoreem300haus.kostal_plenticore","1"]
2022-06-24 12:22:34: PID: 2405: Kostal-Plenticore: Kostal Plenticore Haus: 1
2022-06-24 12:22:34: PID: 2405: legacy run server: Received command ["bezug_kostalplenticoreem300haus.kostal_plenticore","1"]
2022-06-24 12:22:33: PID: 19336: BattLeistung: 1115 (LV1) at 19 main modules/speicher_kostalplenticore/main.sh
2022-06-24 12:22:33: PID: 19336: RET: 0 (LV2) at 17 main modules/speicher_kostalplenticore/main.sh
2022-06-24 12:22:33: PID: 2405: legacy run server: Completed running command in 0.01s: ["speicher_kostalplenticore.kostal_plenticore"]
2022-06-24 12:22:33: PID: 2405: legacy run server: Received command ["speicher_kostalplenticore.kostal_plenticore"]
2022-06-24 12:22:33: PID: 2405: legacy run server: Completed running command in 0.34s: ["wr_plenticore.read_kostalplenticore","xxx.xxx.xxx.xxx","none","1","none"]
2022-06-24 12:22:33: PID: 2405: Kostal-Plenticore: WR1 Leistung = 1818PV_total = 1818
-Battery:1 -WR3:none-WR4:none-WR5:none
2022-06-24 12:22:33: PID: 2405: Kostal-Plenticore: Wechselrichter Kostal Plenticore Config - WR1:xxx.xxx.xxx.xxx -WR2:none
2022-06-24 12:22:33: PID: 2405: legacy run server: Received command ["wr_plenticore.read_kostalplenticore","xxx.xxx.xxx.xxx","none","1","none"]
2022-06-24 12:22:32: PID: 19191: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-06-24 12:22:27: PID: 17816: **** Regulation loop needs 6 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
set-currents: setze ladung auf 30A

Re: Rückmeldungen Stable 1.9.271

Verfasst: Fr Jun 24, 2022 2:12 pm
von LenaK
Wird die Ladeleistung auch auf der Statusseite angezeigt? Im Log steht Ladeleistung 0W.

Code: Alles auswählen

2022-06-24 12:22:35: PID: 19191: pv1watt -1818 pv2watt  pvwatt -1818 ladeleistung 0 llalt 0 nachtladen 1 nachtladen 0 minimalA 10 maximalA 16 (LV1) at 1298 loadvars loadvars.sh
Manchmal hilft es, dass Auto abzustecken und wieder neu anzustecken, damit die Ladeleistungsanzeige wieder funktioniert.
Zudem blinkt die 30A Meldung, obwohl eigentlich gar nicht "Min + PV" eingestellt ist.
Auch bei PV-Laden kann ein Mindest-SoC eingestellt werden.

Laden sollte möglich sein.