Seite 5 von 9

Re: Rückmeldungen Beta 1.9.254

Verfasst: Mo Feb 14, 2022 5:05 pm
von LutzB
Bei Logausgaben bitte immer Code-Formatierung nutzen! Schaltfläche "</>" im Editor.

Setzt die Regelgeschwindigkeit mal auf "langsam" und mach nach ein paar Minuten ein Reboot.

Re: Rückmeldungen Beta 1.9.254

Verfasst: Mo Feb 14, 2022 5:38 pm
von Bogie
Unter Status funktioniert ja die Anzeige der Daten (ab und zu)
Nur auf der Startseite nicht.
Dürfte doch eigentlich nur ein Verknüpfungsproblem sein.
Oder?
Mit der stable war alles i.O.

Ich nutze eine Standalone, die 2 OpenWB als externe Ladepunkte steuert.

Zeitweise wird unter Status der Wert für Speicher geladene kWh mit '0' angezeigt.
Screenshot_20220214_191622.jpg
Screenshot_20220214_191812.jpg
Auf Regelgeschwindigkeit langsam wird nun der Wert aus dem Staus angezeigt. Der passt aber nicht.

Seit dem Update sieht auch die Logging Seite falsch aus:
Screenshot_20220214_195013.jpg
Vor dem Update war alles I. O.
Screenshot_20220214_200953.jpg

Re: Rückmeldungen Beta 1.9.254

Verfasst: Di Feb 15, 2022 11:41 am
von Becker
Hallo,
mir ist aufgefallen dass nach einiger Zeit das Steckersymbol gelb wird:
132.PNG
ist nur ein optisches Problem, laden tut er weiter.

Re: Rückmeldungen Beta 1.9.254

Verfasst: Di Feb 15, 2022 12:08 pm
von HSC
Bogie hat geschrieben: Mo Feb 14, 2022 5:38 pm Unter Status funktioniert ja die Anzeige der Daten (ab und zu)
Nur auf der Startseite nicht.
......
Vor dem Update war alles I. O.
Screenshot_20220214_200953.jpg
Weil Du schreibst, mal wird abgerufen, mal nicht.
Mir war gestern in Deinem DebugLog folgendes aufgefallen, leider gab es den Status da noch nicht. Den sehe ich jetzt eben erst.

Wenn ich diese Zeilen richtig interpretiere, wird gar kein Zähler abgerufen, um daraus Tagessummen bilden zu können.
Im- und Export stehen je auf "0". Vlt. auch nur manchmal (bzw. nicht)?
Ggf. fehlen hier Register? 2 werden ja aufgerufen. Diese (16384, 50235) könnten für die akt. Watt und den SoC sein.

Code: Alles auswählen

2022-02-14 17:48:06: PID: 28099: ValueStore: Saving BatState(exported=0, power=-749.0, soc=93.0, imported=0)
2022-02-14 17:48:06: PID: 28099: [b]SolarEdge: Battery[/b] SoCs=[93.0], powers=[-749.0]
2022-02-14 17:48:06: PID: 28099: pymodbus.payload: [b'\xc4;', b'@\x00']
2022-02-14 17:48:06: PID: 28099: pymodbus.payload: [16384, 50235]
Da sich die Durchläufe alle 10 Sec. wiederholen, könnte es möglich sein, dass Du weiter unten im Log auch mal in der Batteryzeile Daten als Im- und Export hast. Schau mal bitte durch...
VG

Re: Rückmeldungen Beta 1.9.254

Verfasst: Di Feb 15, 2022 3:00 pm
von Bogie

Code: Alles auswählen

 2022-02-15 15:55:41: PID: 8199: SolarEdge EVU: Beginning update
2022-02-15 15:55:37: PID: 7880: Calling SoC-Module <modules/soc_mqtt/main.sh> (LV2) at 7 run_soc_module loadvars.sh
2022-02-15 15:55:35: PID: 8009: SolarEdge: Update completed successfully
2022-02-15 15:55:35: PID: 8009: ValueStore: Saving InverterState(counter=14533337.0, currents=[0.8300000000000001, 0.88, 0.86], power=-226.0)
2022-02-15 15:55:35: PID: 8009: SolarEdge: slave=1: power=4450*10^-1, energy=14533337*10^0, currents=[83, 88, 86] * 10^-2
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [83, 88, 86, 65534]
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Getting transaction 5
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Adding transaction 5
2022-02-15 15:55:35: PID: 8009: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:35: PID: 8009: pymodbus.framer.socket_framer: Processing: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0x0 0x53 0x0 0x58 0x0 0x56 0xff 0xfe
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: RECV: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0x0 0x53 0x0 0x58 0x0 0x56 0xff 0xfe
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: SEND: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x88 0x0 0x4
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Running transaction 5
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [b'\x00\xdd', b'\xc2\xd9']
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [221, 49881, 0]
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Getting transaction 4
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Adding transaction 4
2022-02-15 15:55:35: PID: 8009: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:35: PID: 8009: pymodbus.framer.socket_framer: Processing: 0x0 0x4 0x0 0x0 0x0 0x9 0x1 0x3 0x6 0x0 0xdd 0xc2 0xd9 0x0 0x0
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: RECV: 0x0 0x4 0x0 0x0 0x0 0x9 0x1 0x3 0x6 0x0 0xdd 0xc2 0xd9 0x0 0x0
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: SEND: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x9d 0x0 0x3
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Running transaction 4
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [4450, 65535]
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Getting transaction 3
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Adding transaction 3
2022-02-15 15:55:35: PID: 8009: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:35: PID: 8009: pymodbus.framer.socket_framer: Processing: 0x0 0x3 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x11 0x62 0xff 0xff
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: RECV: 0x0 0x3 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x11 0x62 0xff 0xff
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: SEND: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x93 0x0 0x2
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Running transaction 3
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:35: PID: 8009: ValueStore: Saving BatState(soc=42.0, exported=0, power=-219.0, imported=0)
2022-02-15 15:55:35: PID: 8009: SolarEdge: Battery SoCs=[42.0], powers=[-219.0]
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [b'\xc3[', b'\x00\x00']
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [0, 50011]
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Getting transaction 2
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Adding transaction 2
2022-02-15 15:55:35: PID: 8009: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:35: PID: 8009: pymodbus.framer.socket_framer: Processing: 0x0 0x2 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0xc3 0x5b
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: RECV: 0x0 0x2 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0xc3 0x5b
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: SEND: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xf5 0x74 0x0 0x2
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Running transaction 2
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [b'B(', b'\x00\x00']
2022-02-15 15:55:35: PID: 8009: pymodbus.payload: [0, 16936]
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Getting transaction 1
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Adding transaction 1
2022-02-15 15:55:35: PID: 8009: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:35: PID: 8009: pymodbus.framer.socket_framer: Processing: 0x0 0x1 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0x42 0x28
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: RECV: 0x0 0x1 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0x42 0x28
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:35: PID: 8009: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: SEND: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xf5 0x84 0x0 0x2
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Running transaction 1
2022-02-15 15:55:35: PID: 8009: pymodbus.transaction: Current transaction state - IDLE
2022-02-15 15:55:35: PID: 8009: SolarEdge: Beginning update
2022-02-15 15:55:32: PID: 7880: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:24: PID: 6468: **** FATAL ********************************* (LV0) at 61 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:24: PID: 6468: **** FATAL Regulation loop needs 11 seconds (LV0) at 60 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:23: PID: 6468: **** FATAL ********************************* (LV0) at 59 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:23: PID: 6468: uberschuss -54 wattbezug 54 ladestatus 0 llsoll 0 pvwatt -218 mindestuberschussphasen 1350 wattkombiniert -54 schaltschwelle 1 (LV2) at 575 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:23: PID: 6468: anzahlphasen 1 (LV1) at 574 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:23: PID: 6468: Timing Umschaltung: 480 / 480 (LV1) at 15 u1p3pswitch u1p3p.sh
2022-02-15 15:55:23: PID: 6468: automatische Umschaltung aktiv (LV1) at 14 u1p3pswitch u1p3p.sh
2022-02-15 15:55:23: PID: 6468: Zeit zum abfragen aller Werte 11 Sekunden (LV1) at 176 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:22: PID: 6832: **** Regulation loop needs 0 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:22: PID: 6468: chargestatlp1 0	chargestatlp2 0	chargestatlp3 0 (LV1) at 1275 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: plugstatlp1 0	plugstatlp2 0	plugstatlp3 0 (LV1) at 1274 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: lp1enabled 1	lp2enabled 1	lp3enabled 1 (LV1) at 1273 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: EVU 1:V/-1A 2: V/1A 3: V/1A (LV1) at 1272 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: lla3 0	llv3 226.1	llas13 0 llas23  soclp1 81 soclp2 82 (LV1) at 1271 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: lla2 0	llv2 224.8	llas12 0 llas22  sofortll 16 hausverbrauch 489 wattbezug 54 uberschuss -54 (LV1) at 1270 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: lla1 0	llv1 225.8	llas11 0 llas21  mindestuberschuss 1350 abschaltuberschuss 0 lademodus 4 (LV1) at 1269 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: pv1watt -218 pv2watt  pvwatt -218 ladeleistung 0 llalt 0 nachtladen 0 nachtladen 0 minimalA 6 maximalA 16 (LV1) at 1268 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6468: speicherleistung -217 speichersoc 42 (LV1) at 1263 loadvars loadvars.sh
2022-02-15 15:55:22: PID: 6832: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:21: PID: 6787: SolarEdge EVU: Update completed successfully
2022-02-15 15:55:21: PID: 6787: ValueStore: Saving CounterState(powers=[-77.0, 107.0, 24.0], frequency=50.02, currents=[-1.3, 1.6, 1.1], voltages=[226.54, 226.04, 225.1], imported=4797170, power_factors=[-0.2659, 0.1508, 0.08120000000000001], exported=4791481, power=54.0)
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [b'\x00I', b'\x1c\xb9']
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [73, 7353]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 7
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 7
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x7 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x1c 0xb9
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x7 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x1c 0xb9
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x22 0x0 0x2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 7
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [b'\x00I', b'2\xf2']
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [73, 13042]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 6
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 6
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x6 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x32 0xf2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x6 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x32 0xf2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x2a 0x0 0x2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 6
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [62877, 1508, 812, 65534]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 5
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 5
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xf5 0x9d 0x5 0xe4 0x3 0x2c 0xff 0xfe
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xf5 0x9d 0x5 0xe4 0x3 0x2c 0xff 0xfe
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x1e 0x0 0x4
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 5
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [5002, 65534]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 4
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 4
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x4 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x13 0x8a 0xff 0xfe
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x4 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x13 0x8a 0xff 0xfe
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0xc 0x0 0x2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 4
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [22654, 22604, 22510, 39126, 39186, 39051, 39143, 65534]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 3
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 3
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x3 0x0 0x0 0x0 0x13 0x1 0x3 0x10 0x58 0x7e 0x58 0x4c 0x57 0xee 0x98 0xd6 0x99 0x12 0x98 0x8b 0x98 0xe7 0xff 0xfe
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x3 0x0 0x0 0x0 0x13 0x1 0x3 0x10 0x58 0x7e 0x58 0x4c 0x57 0xee 0x98 0xd6 0x99 0x12 0x98 0x8b 0x98 0xe7 0xff 0xfe
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x4 0x0 0x8
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 3
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [65523, 16, 11, 65535]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 2
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x2 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xff 0xf3 0x0 0x10 0x0 0xb 0xff 0xff
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x2 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xff 0xf3 0x0 0x10 0x0 0xb 0xff 0xff
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0xff 0x0 0x4
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 2
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:21: PID: 6787: pymodbus.payload: [65482, 77, 65429, 65512, 0]
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Getting transaction 1
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Adding transaction 1
2022-02-15 15:55:21: PID: 6787: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:21: PID: 6787: pymodbus.framer.socket_framer: Processing: 0x0 0x1 0x0 0x0 0x0 0xd 0x1 0x3 0xa 0xff 0xca 0x0 0x4d 0xff 0x95 0xff 0xe8 0x0 0x0
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: RECV: 0x0 0x1 0x0 0x0 0x0 0xd 0x1 0x3 0xa 0xff 0xca 0x0 0x4d 0xff 0x95 0xff 0xe8 0x0 0x0
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:21: PID: 6787: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: SEND: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0xe 0x0 0x5
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Running transaction 1
2022-02-15 15:55:21: PID: 6787: pymodbus.transaction: Current transaction state - IDLE
2022-02-15 15:55:21: PID: 6787: SolarEdge EVU: Beginning update
2022-02-15 15:55:17: PID: 6468: Calling SoC-Module <modules/soc_mqtt/main.sh> (LV2) at 7 run_soc_module loadvars.sh
2022-02-15 15:55:15: PID: 6597: SolarEdge: Update completed successfully
2022-02-15 15:55:15: PID: 6597: ValueStore: Saving InverterState(power=-218.0, counter=14533334.0, currents=[0.8300000000000001, 0.88, 0.85])
2022-02-15 15:55:15: PID: 6597: SolarEdge: slave=1: power=4350*10^-1, energy=14533334*10^0, currents=[83, 88, 85] * 10^-2
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [83, 88, 85, 65534]
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Getting transaction 5
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Adding transaction 5
2022-02-15 15:55:15: PID: 6597: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:15: PID: 6597: pymodbus.framer.socket_framer: Processing: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0x0 0x53 0x0 0x58 0x0 0x55 0xff 0xfe
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: RECV: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0x0 0x53 0x0 0x58 0x0 0x55 0xff 0xfe
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: SEND: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x88 0x0 0x4
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Running transaction 5
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [b'\x00\xdd', b'\xc2\xd6']
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [221, 49878, 0]
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Getting transaction 4
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Adding transaction 4
2022-02-15 15:55:15: PID: 6597: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:15: PID: 6597: pymodbus.framer.socket_framer: Processing: 0x0 0x4 0x0 0x0 0x0 0x9 0x1 0x3 0x6 0x0 0xdd 0xc2 0xd6 0x0 0x0
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: RECV: 0x0 0x4 0x0 0x0 0x0 0x9 0x1 0x3 0x6 0x0 0xdd 0xc2 0xd6 0x0 0x0
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: SEND: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x9d 0x0 0x3
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Running transaction 4
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [4350, 65535]
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Getting transaction 3
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Adding transaction 3
2022-02-15 15:55:15: PID: 6597: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:15: PID: 6597: pymodbus.framer.socket_framer: Processing: 0x0 0x3 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x10 0xfe 0xff 0xff
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: RECV: 0x0 0x3 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x10 0xfe 0xff 0xff
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: SEND: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x93 0x0 0x2
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Running transaction 3
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:15: PID: 6597: ValueStore: Saving BatState(exported=0, soc=42.0, power=-217.0, imported=0)
2022-02-15 15:55:15: PID: 6597: SolarEdge: Battery SoCs=[42.0], powers=[-217.0]
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [b'\xc3Y', b'\x00\x00']
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [0, 50009]
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Getting transaction 2
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Adding transaction 2
2022-02-15 15:55:15: PID: 6597: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:15: PID: 6597: pymodbus.framer.socket_framer: Processing: 0x0 0x2 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0xc3 0x59
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: RECV: 0x0 0x2 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0xc3 0x59
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: SEND: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xf5 0x74 0x0 0x2
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Running transaction 2
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [b'B(', b'\x00\x00']
2022-02-15 15:55:15: PID: 6597: pymodbus.payload: [0, 16936]
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Getting transaction 1
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Adding transaction 1
2022-02-15 15:55:15: PID: 6597: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:15: PID: 6597: pymodbus.framer.socket_framer: Processing: 0x0 0x1 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0x42 0x28
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: RECV: 0x0 0x1 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0x42 0x28
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:15: PID: 6597: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: SEND: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xf5 0x84 0x0 0x2
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Running transaction 1
2022-02-15 15:55:15: PID: 6597: pymodbus.transaction: Current transaction state - IDLE
2022-02-15 15:55:15: PID: 6597: SolarEdge: Beginning update
2022-02-15 15:55:12: PID: 6468: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:04: PID: 5140: ##### cron5min.sh finished ##### (LV0) at 426 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:04: PID: 4732: **** FATAL ********************************* (LV0) at 61 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:04: PID: 4732: **** FATAL Regulation loop needs 12 seconds (LV0) at 60 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:04: PID: 4732: **** FATAL ********************************* (LV0) at 59 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:04: PID: 4732: uberschuss -36 wattbezug 36 ladestatus 0 llsoll 0 pvwatt -215 mindestuberschussphasen 1350 wattkombiniert -36 schaltschwelle 1 (LV2) at 575 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:04: PID: 4732: anzahlphasen 1 (LV1) at 574 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:03: PID: 5140: logfile cleanup triggered (LV1) at 423 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:03: PID: 5140: starting evsecheck (LV1) at 419 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:03: PID: 4732: Timing Umschaltung: 480 / 480 (LV1) at 15 u1p3pswitch u1p3p.sh
2022-02-15 15:55:03: PID: 4732: automatische Umschaltung aktiv (LV1) at 14 u1p3pswitch u1p3p.sh
2022-02-15 15:55:03:  Load: 1.09 1.29 1.11
2022-02-15 15:55:03: PID: 5140: pingcheck configured; starting (LV1) at 409 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:03: PID: 5140: modbus tcp server already running (LV1) at 401 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:03: PID: 4732: Zeit zum abfragen aller Werte 11 Sekunden (LV1) at 176 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:02: PID: 5140: external openWB or daemon mode not configured; checking network setup (LV1) at 336 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: smarthome handler is already running (LV1) at 319 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: legacy_run_server is already running (LV1) at 313 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: mqtt handler is already running (LV1) at 300 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: current ip: 192.168.1.160 (LV1) at 295 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5154: **** Regulation loop needs 0 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:55:02: PID: 5140: updating daily yield stats (LV1) at 165 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: electricity provider not set up; skipping price update (LV2) at 161 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: Netzschutz konfiguriert; aktuelle Frequenz: 0 (LV1) at 110 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5140: daily csv updated: /var/www/html/openWB/web/logging/data/daily/20220215.csv (LV1) at 102 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 4732: chargestatlp1 0	chargestatlp2 0	chargestatlp3 0 (LV1) at 1275 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: plugstatlp1 0	plugstatlp2 0	plugstatlp3 0 (LV1) at 1274 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: lp1enabled 1	lp2enabled 1	lp3enabled 1 (LV1) at 1273 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: EVU 1:V/-1A 2: V/1A 3: V/1A (LV1) at 1272 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: lla3 0	llv3 225.9	llas13 0 llas23  soclp1 81 soclp2 82 (LV1) at 1271 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: lla2 0	llv2 224.7	llas12 0 llas22  sofortll 16 hausverbrauch 480 wattbezug 36 uberschuss -36 (LV1) at 1270 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: lla1 0	llv1 225.5	llas11 0 llas21  mindestuberschuss 1350 abschaltuberschuss 0 lademodus 4 (LV1) at 1269 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: pv1watt -215 pv2watt  pvwatt -215 ladeleistung 0 llalt 0 nachtladen 0 nachtladen 0 minimalA 6 maximalA 16 (LV1) at 1268 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 4732: speicherleistung -229 speichersoc 42 (LV1) at 1263 loadvars loadvars.sh
2022-02-15 15:55:02: PID: 5140: ##### cron5min.sh started ##### (LV0) at 23 main /var/www/html/openWB/runs/cron5min.sh
2022-02-15 15:55:02: PID: 5154: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-02-15 15:55:01: PID: 5052: SolarEdge EVU: Update completed successfully
2022-02-15 15:55:01: PID: 5052: ValueStore: Saving CounterState(powers=[-80.0, 95.0, 21.0], exported=4791481, voltages=[226.26, 225.75, 225.23000000000002], currents=[-1.3, 1.7000000000000002, 1.1], power_factors=[-0.2664, 0.2275, 0.0809], imported=4797170, frequency=49.980000000000004, power=36.0)
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [b'\x00I', b'\x1c\xb9']
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [73, 7353]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 7
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 7
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x7 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x1c 0xb9
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x7 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x1c 0xb9
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x22 0x0 0x2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 7
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [b'\x00I', b'2\xf2']
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [73, 13042]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 6
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 6
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x6 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x32 0xf2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x6 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x32 0xf2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x2a 0x0 0x2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 6
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [62872, 2275, 809, 65534]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 5
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 5
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xf5 0x98 0x8 0xe3 0x3 0x29 0xff 0xfe
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xf5 0x98 0x8 0xe3 0x3 0x29 0xff 0xfe
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x1e 0x0 0x4
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 5
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [4998, 65534]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 4
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 4
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x4 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x13 0x86 0xff 0xfe
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x4 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x13 0x86 0xff 0xfe
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0xc 0x0 0x2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 4
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [22626, 22575, 22523, 39100, 39135, 39031, 39134, 65534]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 3
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 3
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x3 0x0 0x0 0x0 0x13 0x1 0x3 0x10 0x58 0x62 0x58 0x2f 0x57 0xfb 0x98 0xbc 0x98 0xdf 0x98 0x77 0x98 0xde 0xff 0xfe
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x3 0x0 0x0 0x0 0x13 0x1 0x3 0x10 0x58 0x62 0x58 0x2f 0x57 0xfb 0x98 0xbc 0x98 0xdf 0x98 0x77 0x98 0xde 0xff 0xfe
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x4 0x0 0x8
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 3
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [65523, 17, 11, 65535]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 2
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x2 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xff 0xf3 0x0 0x11 0x0 0xb 0xff 0xff
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x2 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xff 0xf3 0x0 0x11 0x0 0xb 0xff 0xff
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0xff 0x0 0x4
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 2
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:55:01: PID: 5052: pymodbus.payload: [65500, 80, 65441, 65515, 0]
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Getting transaction 1
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Adding transaction 1
2022-02-15 15:55:01: PID: 5052: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:55:01: PID: 5052: pymodbus.framer.socket_framer: Processing: 0x0 0x1 0x0 0x0 0x0 0xd 0x1 0x3 0xa 0xff 0xdc 0x0 0x50 0xff 0xa1 0xff 0xeb 0x0 0x0
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: RECV: 0x0 0x1 0x0 0x0 0x0 0xd 0x1 0x3 0xa 0xff 0xdc 0x0 0x50 0xff 0xa1 0xff 0xeb 0x0 0x0
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:55:01: PID: 5052: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: SEND: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0xe 0x0 0x5
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Running transaction 1
2022-02-15 15:55:01: PID: 5052: pymodbus.transaction: Current transaction state - IDLE
2022-02-15 15:55:01: PID: 5052: SolarEdge EVU: Beginning update
2022-02-15 15:54:57: PID: 4732: Calling SoC-Module <modules/soc_mqtt/main.sh> (LV2) at 7 run_soc_module loadvars.sh
2022-02-15 15:54:55: PID: 4862: SolarEdge: Update completed successfully
2022-02-15 15:54:55: PID: 4862: ValueStore: Saving InverterState(counter=14533332.0, currents=[0.8300000000000001, 0.87, 0.85], power=-215.0)
2022-02-15 15:54:55: PID: 4862: SolarEdge: slave=1: power=4440*10^-1, energy=14533332*10^0, currents=[83, 87, 85] * 10^-2
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [83, 87, 85, 65534]
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Getting transaction 5
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Adding transaction 5
2022-02-15 15:54:55: PID: 4862: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:55: PID: 4862: pymodbus.framer.socket_framer: Processing: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0x0 0x53 0x0 0x57 0x0 0x55 0xff 0xfe
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: RECV: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0x0 0x53 0x0 0x57 0x0 0x55 0xff 0xfe
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: SEND: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x88 0x0 0x4
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Running transaction 5
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [b'\x00\xdd', b'\xc2\xd4']
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [221, 49876, 0]
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Getting transaction 4
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Adding transaction 4
2022-02-15 15:54:55: PID: 4862: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:55: PID: 4862: pymodbus.framer.socket_framer: Processing: 0x0 0x4 0x0 0x0 0x0 0x9 0x1 0x3 0x6 0x0 0xdd 0xc2 0xd4 0x0 0x0
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: RECV: 0x0 0x4 0x0 0x0 0x0 0x9 0x1 0x3 0x6 0x0 0xdd 0xc2 0xd4 0x0 0x0
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: SEND: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x9d 0x0 0x3
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Running transaction 4
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [4440, 65535]
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Getting transaction 3
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Adding transaction 3
2022-02-15 15:54:55: PID: 4862: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:55: PID: 4862: pymodbus.framer.socket_framer: Processing: 0x0 0x3 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x11 0x58 0xff 0xff
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: RECV: 0x0 0x3 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x11 0x58 0xff 0xff
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: SEND: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x9c 0x93 0x0 0x2
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Running transaction 3
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:55: PID: 4862: ValueStore: Saving BatState(soc=42.0, power=-229.0, exported=0, imported=0)
2022-02-15 15:54:55: PID: 4862: SolarEdge: Battery SoCs=[42.0], powers=[-229.0]
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [b'\xc3e', b'\x00\x00']
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [0, 50021]
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Getting transaction 2
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Adding transaction 2
2022-02-15 15:54:55: PID: 4862: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:55: PID: 4862: pymodbus.framer.socket_framer: Processing: 0x0 0x2 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0xc3 0x65
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: RECV: 0x0 0x2 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0xc3 0x65
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: SEND: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xf5 0x74 0x0 0x2
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Running transaction 2
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [b'B(', b'\x00\x00']
2022-02-15 15:54:55: PID: 4862: pymodbus.payload: [0, 16936]
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Getting transaction 1
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Adding transaction 1
2022-02-15 15:54:55: PID: 4862: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:55: PID: 4862: pymodbus.framer.socket_framer: Processing: 0x0 0x1 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0x42 0x28
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: RECV: 0x0 0x1 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x0 0x42 0x28
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:55: PID: 4862: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: SEND: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xf5 0x84 0x0 0x2
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Running transaction 1
2022-02-15 15:54:55: PID: 4862: pymodbus.transaction: Current transaction state - IDLE
2022-02-15 15:54:55: PID: 4862: SolarEdge: Beginning update
2022-02-15 15:54:52: PID: 4732: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-02-15 15:54:43: PID: 3323: **** FATAL ********************************* (LV0) at 61 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:54:43: PID: 3323: **** FATAL Regulation loop needs 11 seconds (LV0) at 60 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:54:43: PID: 3323: **** FATAL ********************************* (LV0) at 59 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:54:43: PID: 3323: uberschuss -46 wattbezug 46 ladestatus 0 llsoll 0 pvwatt -202 mindestuberschussphasen 1350 wattkombiniert -46 schaltschwelle 1 (LV2) at 575 main /var/www/html/openWB/regel.sh
2022-02-15 15:54:43: PID: 3323: anzahlphasen 1 (LV1) at 574 main /var/www/html/openWB/regel.sh
2022-02-15 15:54:43: PID: 3323: Timing Umschaltung: 480 / 480 (LV1) at 15 u1p3pswitch u1p3p.sh
2022-02-15 15:54:43: PID: 3323: automatische Umschaltung aktiv (LV1) at 14 u1p3pswitch u1p3p.sh
2022-02-15 15:54:43: PID: 3323: Zeit zum abfragen aller Werte 11 Sekunden (LV1) at 176 main /var/www/html/openWB/regel.sh
2022-02-15 15:54:42: PID: 3699: **** Regulation loop needs 0 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
2022-02-15 15:54:42: PID: 3323: chargestatlp1 0	chargestatlp2 0	chargestatlp3 0 (LV1) at 1275 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: plugstatlp1 0	plugstatlp2 0	plugstatlp3 0 (LV1) at 1274 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: lp1enabled 1	lp2enabled 1	lp3enabled 1 (LV1) at 1273 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: EVU 1:V/-1A 2: V/1A 3: V/1A (LV1) at 1272 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: lla3 0	llv3 226.0	llas13 0 llas23  soclp1 81 soclp2 82 (LV1) at 1271 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: lla2 0	llv2 224.4	llas12 0 llas22  sofortll 16 hausverbrauch 485 wattbezug 46 uberschuss -46 (LV1) at 1270 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: lla1 0	llv1 225.3	llas11 0 llas21  mindestuberschuss 1350 abschaltuberschuss 0 lademodus 4 (LV1) at 1269 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: pv1watt -202 pv2watt  pvwatt -202 ladeleistung 0 llalt 0 nachtladen 0 nachtladen 0 minimalA 6 maximalA 16 (LV1) at 1268 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3323: speicherleistung -237 speichersoc 42 (LV1) at 1263 loadvars loadvars.sh
2022-02-15 15:54:42: PID: 3699: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-02-15 15:54:41: PID: 3643: SolarEdge EVU: Update completed successfully
2022-02-15 15:54:41: PID: 3643: ValueStore: Saving CounterState(imported=4797170, frequency=49.980000000000004, power=46.0, powers=[-77.0, 101.0, 22.0], exported=4791481, power_factors=[-0.26780000000000004, 0.2463, 0.0723], voltages=[226.43, 225.61, 224.85], currents=[-1.3, 1.7000000000000002, 1.1])
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [b'\x00I', b'\x1c\xb9']
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [73, 7353]
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Getting transaction 7
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Adding transaction 7
2022-02-15 15:54:41: PID: 3643: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:41: PID: 3643: pymodbus.framer.socket_framer: Processing: 0x0 0x7 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x1c 0xb9
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: RECV: 0x0 0x7 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x1c 0xb9
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: SEND: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x22 0x0 0x2
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Running transaction 7
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [b'\x00I', b'2\xf2']
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [73, 13042]
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Getting transaction 6
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Adding transaction 6
2022-02-15 15:54:41: PID: 3643: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:41: PID: 3643: pymodbus.framer.socket_framer: Processing: 0x0 0x6 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x32 0xf2
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: RECV: 0x0 0x6 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x0 0x49 0x32 0xf2
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: SEND: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x2a 0x0 0x2
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Running transaction 6
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [62858, 2463, 723, 65534]
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Getting transaction 5
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Adding transaction 5
2022-02-15 15:54:41: PID: 3643: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:41: PID: 3643: pymodbus.framer.socket_framer: Processing: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xf5 0x8a 0x9 0x9f 0x2 0xd3 0xff 0xfe
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: RECV: 0x0 0x5 0x0 0x0 0x0 0xb 0x1 0x3 0x8 0xf5 0x8a 0x9 0x9f 0x2 0xd3 0xff 0xfe
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: SEND: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x1e 0x0 0x4
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Running transaction 5
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [4998, 65534]
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Getting transaction 4
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Adding transaction 4
2022-02-15 15:54:41: PID: 3643: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:41: PID: 3643: pymodbus.framer.socket_framer: Processing: 0x0 0x4 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x13 0x86 0xff 0xfe
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: RECV: 0x0 0x4 0x0 0x0 0x0 0x7 0x1 0x3 0x4 0x13 0x86 0xff 0xfe
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: SEND: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0xc 0x0 0x2
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Running transaction 4
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [22643, 22561, 22485, 39080, 39137, 39012, 39091, 65534]
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Getting transaction 3
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Adding transaction 3
2022-02-15 15:54:41: PID: 3643: pymodbus.factory: Factory Response[ReadHoldingRegistersResponse: 3]
2022-02-15 15:54:41: PID: 3643: pymodbus.framer.socket_framer: Processing: 0x0 0x3 0x0 0x0 0x0 0x13 0x1 0x3 0x10 0x58 0x73 0x58 0x21 0x57 0xd5 0x98 0xa8 0x98 0xe1 0x98 0x64 0x98 0xb3 0xff 0xfe
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: RECV: 0x0 0x3 0x0 0x0 0x0 0x13 0x1 0x3 0x10 0x58 0x73 0x58 0x21 0x57 0xd5 0x98 0xa8 0x98 0xe1 0x98 0x64 0x98 0xb3 0xff 0xfe
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'WAITING FOR REPLY' to 'PROCESSING REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'SENDING' to 'WAITING FOR REPLY'
2022-02-15 15:54:41: PID: 3643: pymodbus.client.sync: New Transaction state 'SENDING'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: SEND: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x9d 0x4 0x0 0x8
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Running transaction 3
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Current transaction state - TRANSACTION_COMPLETE
2022-02-15 15:54:41: PID: 3643: pymodbus.payload: [65523, 17, 11, 65535]
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Changing transaction state from 'PROCESSING REPLY' to 'TRANSACTION_COMPLETE'
2022-02-15 15:54:41: PID: 3643: pymodbus.transaction: Getting 

Re: Rückmeldungen Beta 1.9.254

Verfasst: Di Feb 15, 2022 3:30 pm
von HSC
Mmh, ohne weitere Info, was z. Zt. Stand ist, ist das schlecht. Deine Startseite und der BatterieStatus während des LogAuszuges wäre schon sinnvoll.
In dieser 1 Min. Log konnte ich immer nur "0" je für Im- und Export in der Zeile finden. Was da nun ist, kann ich nicht beantworten.
Allerdings sieht Dein Tageslog vom 12.2. schon ziemlich merkwürdig aus. Dort passen die Verhältnisse zw. PV/LP und Speicherladung bzw. -Entladung nicht. Irgendwie scheint da ein Faktorfehler (10-fache Speicherleistung) drin zu sein. Hast Du am 12. vormittags geupdatet?

Da es bei Dir um eine SE- Anlage geht, wäre es für den Support ggf. sinnvoll, einen eigenen Beitrag zu starten und von heute so viel wie möglich Daten zu liefern (Startseite, Statusdaten, Tageslog, DebugLog). Der Tag des updates enthält bei Fehlern oft utopische Summen oder eben keine.
VG

Re: Rückmeldungen Beta 1.9.254

Verfasst: Di Feb 15, 2022 4:30 pm
von Gagadada
Hallo zusammen,

ich betreibe eine Standard+ mit Display als Master und eine Custom als Slave mit dem neuen Update 254. Hierzu habe ich Fragen:

1. Wenn ich auf dem Touch Screen eine Wischgeste von links nach rechts mache, startet die OpenWB neu. Dies geschieht bei allen getesteten Themes. Ist dies ein Feature oder ein Bug? :D Was soll eigentlich bei der Wischgeste passieren bzw. welche Gesten gibt es?
20220213_191652.jpg
20220213_191701.jpg
2. Es blinkt der 2. Ladepunkt blau (Open WB Custom), auch wenn kein Auto angeschlossen wurde. Was hat das zu bedeuten? Gibt es hierzu bereits andere Rückmeldungen?

3. Ich nutze die OpenWB zum Schalten von Lasten per Fritz Smart Home Steckdosen. Das klappt wunderbar und ich bin sehr zufrieden. Bei der Visualisierung gibt es allerdings Unstimmugkeiten. Die Last wird "wellig" angezeigt. Im Beispiel wurde ein Roller geladen, was eigentlich eine sehr konstante Last ist. Gibts hier vielleicht Probleme beim Datenabruf zwischen Fritz Geräten und der OpenWB?
Smart Home Fritz.JPG
Vielleicht auch Wichtig: Die genannten Bugs sind mir schon bei der letzten Stable (244?) aufgefallen.


Vielen Dank und viele Grüße,
Sebastian

Re: Rückmeldungen Beta 1.9.254

Verfasst: Di Feb 15, 2022 6:00 pm
von Bogie
[attachment=0]Screenshot_20220215_190044.jpg[/attachment]Seit ich die Regelgeschwindigkeit auf 'langsam' gestellt habe, werden die Lade - und Entladesummen aus dem Speicher wieder auf der Startseite angezeigt.

Warum muss mir der neuen Version die Regelgeschwindigkeit reduziert werden?

Ich werde morgen mal den Gegenversuch starten und die Regelgeschwindigkeit wieder auf 'normal' stellen.

Re: Rückmeldungen Beta 1.9.254

Verfasst: Mi Feb 16, 2022 6:45 am
von LutzB
Gagadada hat geschrieben: Di Feb 15, 2022 4:30 pm Hallo zusammen,

ich betreibe eine Standard+ mit Display als Master und eine Custom als Slave mit dem neuen Update 254. Hierzu habe ich Fragen:

1. Wenn ich auf dem Touch Screen eine Wischgeste von links nach rechts mache, startet die OpenWB neu. Dies geschieht bei allen getesteten Themes. Ist dies ein Feature oder ein Bug? :D Was soll eigentlich bei der Wischgeste passieren bzw. welche Gesten gibt es?
Das ist lediglich die "zurück" Geste des Browsers. OpenWB startet dadurch nicht neu. Falls jemand eine Idee hat, wie man das abschalten kann, bitte melden.
Gagadada hat geschrieben: Di Feb 15, 2022 4:30 pm 3. Ich nutze die OpenWB zum Schalten von Lasten per Fritz Smart Home Steckdosen. Das klappt wunderbar und ich bin sehr zufrieden. Bei der Visualisierung gibt es allerdings Unstimmugkeiten. Die Last wird "wellig" angezeigt. Im Beispiel wurde ein Roller geladen, was eigentlich eine sehr konstante Last ist. Gibts hier vielleicht Probleme beim Datenabruf zwischen Fritz Geräten und der OpenWB?
Hat die Steckdose eine eigene Ernergiemessung? Wird dort auch ein Zählerstand übertragen? Wenn ja, ist vermutlich die Auflösung zu gering. In den Diagrammen werden Differenzen der Zählerstände genutzt. Wenn die Auflösung zu gering ist, kommt es zu solchen Effekten. Die Anwender mit einem Go-e können ein Lied davon singen.

Re: Rückmeldungen Beta 1.9.254

Verfasst: Mi Feb 16, 2022 6:47 am
von LutzB
Bogie hat geschrieben: Di Feb 15, 2022 6:00 pm Screenshot_20220215_190044.jpgSeit ich die Regelgeschwindigkeit auf 'langsam' gestellt habe, werden die Lade - und Entladesummen aus dem Speicher wieder auf der Startseite angezeigt.

Warum muss mir der neuen Version die Regelgeschwindigkeit reduziert werden?

Ich werde morgen mal den Gegenversuch starten und die Regelgeschwindigkeit wieder auf 'normal' stellen.
Es liegt aktuell an der langen Durchlaufzeit der Regelschleife. Dann kommt es zu Überschneidungen und allerlei seltsamen Effekten.
Wir arbeiten dran: https://github.com/snaptec/openWB/pull/2039