Rückmeldungen Nightly 1.9.276

Fragen zur Nutzung, Features, usw..
blueberry63
Beiträge: 79
Registriert: Sa Jan 11, 2020 5:50 pm

Re: Rückmeldungen Nightly 1.9.276

Beitrag von blueberry63 »

Hallo,

ich habe gesterrn Abend auch auf die letzte Nightly aktualisiert und bekomme jetzt diese Meldungen im LOG:

Code: Alles auswählen

2022-09-06 08:39:20: PID: 27185: **** FATAL ********************************* (LV0)
2022-09-06 08:39:20: PID: 27185: **** FATAL Regulation loop needs 10 seconds (LV0)
2022-09-06 08:39:20: PID: 27185: **** FATAL ********************************* (LV0)
2022-09-06 08:39:10: PID: 25865: **** FATAL ********************************* (LV0)
2022-09-06 08:39:10: PID: 25865: **** FATAL Regulation loop needs 10 seconds (LV0)
2022-09-06 08:39:10: PID: 25865: **** FATAL ********************************* (LV0)
2022-09-06 08:39:00: PID: 24721: **** FATAL ********************************* (LV0)
2022-09-06 08:39:00: PID: 24721: **** FATAL Regulation loop needs 10 seconds (LV0)
2022-09-06 08:39:00: PID: 24721: **** FATAL ********************************* (LV0)
2022-09-06 08:38:49: PID: 23429: **** FATAL ********************************* (LV0)
2022-09-06 08:38:49: PID: 23429: **** FATAL Regulation loop needs 9 seconds (LV0)
2022-09-06 08:38:49: PID: 23429: **** FATAL ********************************* (LV0)
2022-09-06 08:38:39: PID: 22006: **** FATAL ********************************* (LV0)
2022-09-06 08:38:39: PID: 22006: **** FATAL Regulation loop needs 9 seconds (LV0)
2022-09-06 08:38:39: PID: 22006: **** FATAL ********************************* (LV0)
2022-09-06 08:38:30: PID: 20829: **** FATAL ********************************* (LV0)
2022-09-06 08:38:30: PID: 20829: **** FATAL Regulation loop needs 10 seconds (LV0)
2022-09-06 08:38:30: PID: 20829: **** FATAL ********************************* (LV0)
2022-09-06 08:38:19: PID: 19552: **** FATAL ********************************* (LV0)
2022-09-06 08:38:19: PID: 19552: **** FATAL Regulation loop needs 9 seconds (LV0)
2022-09-06 08:38:19: PID: 19552: **** FATAL ********************************* (LV0)
2022-09-06 08:38:09: PID: 18010: **** FATAL ********************************* (LV0)
2022-09-06 08:38:09: PID: 18010: **** FATAL Regulation loop needs 9 seconds (LV0)
2022-09-06 08:38:09: PID: 18010: **** FATAL ********************************* (LV0)
2022-09-06 08:38:00: PID: 16954: **** FATAL ********************************* (LV0)
2022-09-06 08:38:00: PID: 16954: **** FATAL Regulation loop needs 9 seconds (LV0)
2022-09-06 08:38:00: PID: 16954: **** FATAL ********************************* (LV0)
Wir haben einen Wechselrichter (Tripower 5.0) und Homemanager 2.0 von SMA.

Gruß
Blueberry63
derNeueDet
Beiträge: 4229
Registriert: Mi Nov 11, 2020 7:16 pm

Re: Rückmeldungen Nightly 1.9.276

Beitrag von derNeueDet »

Das sieht doch soweit gut aus. Die Fatal Meldungen kommen, weil die Abfrage der Werte länger als 8 Sekunden dauert. 10s ist das Regelintervall. Da sind 10s Laufzeit hart an der Grenze. Evtl. Das Regelimtervall mal auf langsam umstellen (20s).

VG
Det
10kWp PV mit SMA Tripower 10000TL-10 (PE11 mit SDM72V2); 2,4kWp mit Solis 2.5 G6 (EE11 mit SDM120). OpenWB Standard+. EVU EM540 an einem Raspi mit Venus OS. BEV Mercedes EQA 250 (07/2023)
blueberry63
Beiträge: 79
Registriert: Sa Jan 11, 2020 5:50 pm

Re: Rückmeldungen Nightly 1.9.276

Beitrag von blueberry63 »

Ich habe das Regelintervall mal auf "langsam" umgestellt. Die Meldungen im Log kommen aber immer noch, jetzt allerdings mit höherer Laufzeit:

Code: Alles auswählen

2022-09-06 10:58:57: PID: 24954: **** FATAL ********************************* (LV0)
2022-09-06 10:58:57: PID: 24954: **** FATAL Regulation loop needs 16 seconds (LV0)
2022-09-06 10:58:57: PID: 24954: **** FATAL ********************************* (LV0)
2022-09-06 10:58:35: PID: 23602: **** FATAL ********************************* (LV0)
2022-09-06 10:58:35: PID: 23602: **** FATAL Regulation loop needs 14 seconds (LV0)
2022-09-06 10:58:35: PID: 23602: **** FATAL ********************************* (LV0)
2022-09-06 10:58:15: PID: 22240: **** FATAL ********************************* (LV0)
2022-09-06 10:58:15: PID: 22240: **** FATAL Regulation loop needs 14 seconds (LV0)
2022-09-06 10:58:15: PID: 22240: **** FATAL ********************************* (LV0)
2022-09-06 10:57:55: PID: 20857: **** FATAL ********************************* (LV0)
2022-09-06 10:57:55: PID: 20857: **** FATAL Regulation loop needs 14 seconds (LV0)
2022-09-06 10:57:55: PID: 20857: **** FATAL ********************************* (LV0)
2022-09-06 10:57:43: PID: 19512: **** FATAL ********************************* (LV0)
2022-09-06 10:57:43: PID: 19512: **** FATAL Regulation loop needs 22 seconds (LV0)
2022-09-06 10:57:43: PID: 19512: **** FATAL ********************************* (LV0)
2022-09-06 10:57:17: PID: 18152: **** FATAL ********************************* (LV0)
2022-09-06 10:57:17: PID: 18152: **** FATAL Regulation loop needs 16 seconds (LV0)
2022-09-06 10:57:17: PID: 18152: **** FATAL ********************************* (LV0)
2022-09-06 10:56:58: PID: 16740: **** FATAL ********************************* (LV0)
2022-09-06 10:56:58: PID: 16740: **** FATAL Regulation loop needs 18 seconds (LV0)
2022-09-06 10:56:58: PID: 16740: **** FATAL ********************************* (LV0)
2022-09-06 10:56:41: PID: 15396: **** FATAL ********************************* (LV0)
2022-09-06 10:56:41: PID: 15396: **** FATAL Regulation loop needs 21 seconds (LV0)
2022-09-06 10:56:41: PID: 15396: **** FATAL ********************************* (LV0)
2022-09-06 10:56:15: PID: 14021: **** FATAL ********************************* (LV0)
2022-09-06 10:56:15: PID: 14021: **** FATAL Regulation loop needs 15 seconds (LV0)
2022-09-06 10:56:15: PID: 14021: **** FATAL ********************************* (LV0)
Mir ist noch etwas aufgefallen: ich greife noch von anderer Stelle per Modbus auf den SMA Wechselrichter zu und dort funktioniert der Abruf auch nicht mehr zu 100% (es werden nur noch einzelne Daten empfangen). Alles sehr komisch...

Gru0
Blueberry63
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Rückmeldungen Nightly 1.9.276

Beitrag von LenaK »

Dr. Mad hat geschrieben: Mo Sep 05, 2022 11:07 pm [edit: IP-Adresse SMA SB 3.0 korrigiert]

Gerade auf Version: 1.9.276 (2022-09-05 16:04:00 +0200 [cab8dd98] aktualisiert (2x mal hintereinander, um sicher zu gehen). Es gibt nun (im Debug Modus 0) alle paar Sekuden den Fehler

Code: Alles auswählen

/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
Wir haben: SMA Home Manager 2.0 (192.168.178.97), SMA Sunny Tripower 10.0 Smart Energy (192.168.178.101) , SMA Sunny Tripower 8.0 (192.168.178.102) und SMA Sunnyboy 3.0 (192.168.178.103), openWB (192.168.178.165), sowie eine weitere als 2. Ladepunkt (192.168.178.136).

Anmerkung: der Sunnyboy 3.0 ersetzt seit ein paar Tagen die zwei Wechselrichter SMA Sunnyboy 1.5 und Solaredge SE2200H; die Probleme mit der doppelten Erfassung von PV mit diesem Setup sind unverändert zum alten Setup und zur Nightly 1.9.274, wie ich zuletzt berichtet hatte in viewtopic.php?p=70750#p70750

Der neue Fehler oben tritt auf, egal, ob ich den Batteriespeicher (192.168.178.101) als „Sunny Boy Smart Energy“ ja oder nein konfigueriere (unten das Log in Modus 2 für nein). PV-Modul 1 ist auf „SMA ModusTCP WR“ mit „Hybrid-System“=ja und obigen drei IP-Adressen 192.168.178.101-103 konfiguriert, WR2 = nicht vorhanden.

Hier wie gewünscht noch die Ausgabe mit Debug Modus 2:

Code: Alles auswählen

2022-09-06 00:42:07: PID: 31073: **** Regulation loop needs 6 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
2022-09-06 00:42:07: PID: 31073: Überschuss 5; mindestens 500 (LV1) at 104 nurpvlademodus nurpv.sh
2022-09-06 00:42:07: PID: 31073: uberschuss 5 wattbezug -5 ladestatus 0 llsoll 0 pvwatt 0 mindestuberschussphasen 500 wattkombiniert 5 schaltschwelle 230 (LV2) at 576 main /var/www/html/openWB/regel.sh
2022-09-06 00:42:07: PID: 31073: anzahlphasen 1 (LV1) at 575 main /var/www/html/openWB/regel.sh
2022-09-06 00:42:07: PID: 31073: Timing Umschaltung: 480 / 480 (LV1) at 17 u1p3pswitch u1p3p.sh
2022-09-06 00:42:07: PID: 31073: automatische Umschaltung aktiv (LV1) at 16 u1p3pswitch u1p3p.sh
2022-09-06 00:42:06: PID: 31073: Zeit zum abfragen aller Werte 5 Sekunden (LV1) at 176 main /var/www/html/openWB/regel.sh
2022-09-06 00:42:05: PID: 31073: chargestatlp1 0 chargestatlp2 0 chargestatlp3 0 (LV1) at 1300 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: plugstatlp1 0 plugstatlp2 0 plugstatlp3 0 (LV1) at 1299 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: lp1enabled 1 lp2enabled 1 lp3enabled 1 (LV1) at 1298 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: EVU 1:V/-1A 2: V/-1A 3: V/2A (LV1) at 1297 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: lla3 0 llv3 235.0 llas13 0 llas23  soclp1 0 soclp2 0 (LV1) at 1296 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: lla2 0 llv2 234.2 llas12 0 llas22  sofortll 16 hausverbrauch 1305 wattbezug -5 uberschuss 5 (LV1) at 1295 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: lla1 0 llv1 235.3 llas11 0 llas21  mindestuberschuss 500 abschaltuberschuss -5 lademodus 2 (LV1) at 1294 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: pv1watt 0 pv2watt  pvwatt 0 ladeleistung 0 llalt 0 nachtladen 0 nachtladen 0 minimalA 6 maximalA 32 (LV1) at 1293 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31073: speicherleistung -1310 speichersoc 55 (LV1) at 1288 loadvars loadvars.sh
2022-09-06 00:42:05: PID: 31381: EVU RET: 0 (LV2) at 15 main modules/bezug_smashm/main.sh
2022-09-06 00:42:05: PID: 4345: legacy run server: Completed running command in 0.24s: ["modules.sma_shm.device","counter","3007889034"]
2022-09-06 00:42:05: PID: 4345: modules.sma_shm.device: Update complete
2022-09-06 00:42:05: PID: 4345: modules.sma_shm.device: All components updated
2022-09-06 00:42:05: PID: 4345: soc.modules.common.store._api: Saving CounterState(exported=26150679.5, power=-5.3, power_factors=[0.91, 0.443, 0.848], currents=[-1.337, -1.435, 2.103], powers=[-268.3, -106.7, 369.7], imported=17987440.2, voltages=[235.521, 235.699, 234.359], frequency=50.018)
2022-09-06 00:42:05: PID: 4345: modules.sma_shm.device: Beginning update
2022-09-06 00:42:05: PID: 4345: legacy run server: Received command ["modules.sma_shm.device","counter","3007889034"]
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
2022-09-06 00:42:02: PID: 31275: BattLeistung: -1310 (LV1) at 28 main modules/speicher_sbs25/main.sh
2022-09-06 00:42:02: PID: 31275: RET: 0 (LV2) at 24 main modules/speicher_sbs25/main.sh
2022-09-06 00:42:02: PID: 4345: legacy run server: Completed running command in 0.15s: ["modules.sma_sunny_boy.device","bat","192.168.178.101"]
2022-09-06 00:42:02: PID: 4345: soc.modules.common.store._api: Saving BatState(soc=55, imported=349621, exported=287097, power=-1310)
2022-09-06 00:42:02: PID: 4345: soc.modules.common.component_context: Update Komponente ['Sma Sunny Boy Speicher']
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: Start device reading {'componentNone': <modules.sma_sunny_boy.bat.SunnyBoyBat object at 0x7506bcd0>}
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Hybrid: None
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Version: None
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus weitere IPs: None, None, None
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Webbox: None
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Ip-Adresse: 192.168.178.101
2022-09-06 00:42:02: PID: 4345: legacy run server: Received command ["modules.sma_sunny_boy.device","bat","192.168.178.101"]
2022-09-06 00:42:02: PID: 31259: RET: 0 (LV2) at 12 main modules/wr_tripower9000/main.sh
2022-09-06 00:42:02: PID: 4345: legacy run server: WR 1 nach Korrektur: InverterState(power=-1310, exported=922960, currents=[0.0, 0.0, 0.0])
2022-09-06 00:42:02: PID: 4345: legacy run server: Completed running command in 0.48s: ["modules.sma_sunny_boy.device","inverter","192.168.178.101","0","192.168.178.102","192.168.178.103"
2022-09-06 00:42:02: PID: 4345: soc.modules.common.store._api: Saving InverterState(power=0, exported=15396762, currents=[0.0, 0.0, 0.0])
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.inverter: WR 192.168.178.103: InverterState(power=0, exported=56757, currents=[0.0, 0.0, 0.0]), DC Power True
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.inverter: WR 192.168.178.102: InverterState(power=0, exported=14417045, currents=[0.0, 0.0, 0.0]), DC Power True
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.inverter: WR 192.168.178.101: InverterState(power=-1310, exported=922960, currents=[0.0, 0.0, 0.0]), DC Power False
2022-09-06 00:42:02: PID: 4345: soc.modules.common.component_context: Update Komponente ['Sma Sunny Boy/Tripower Wechselrichter']
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Hybrid: 1
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Version: 0
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus weitere IPs: 192.168.178.102, 192.168.178.103, none
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Webbox: 0
2022-09-06 00:42:02: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Ip-Adresse: 192.168.178.101
2022-09-06 00:42:02: PID: 4345: legacy run server: Received command ["modules.sma_sunny_boy.device","inverter","192.168.178.101","0","192.168.178.102","192.168.178.103"
2022-09-06 00:42:01: PID: 31073: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
2022-09-06 00:41:58: PID: 29681: **** Regulation loop needs 7 seconds (LV2) at 55 cleanup /var/www/html/openWB/regel.sh
2022-09-06 00:41:58: PID: 29681: Überschuss 0; mindestens 500 (LV1) at 104 nurpvlademodus nurpv.sh
2022-09-06 00:41:57: PID: 29681: uberschuss 0 wattbezug 0 ladestatus 0 llsoll 0 pvwatt 0 mindestuberschussphasen 500 wattkombiniert 0 schaltschwelle 230 (LV2) at 576 main /var/www/html/openWB/regel.sh
2022-09-06 00:41:57: PID: 29681: anzahlphasen 1 (LV1) at 575 main /var/www/html/openWB/regel.sh
2022-09-06 00:41:57: PID: 29681: Timing Umschaltung: 480 / 480 (LV1) at 17 u1p3pswitch u1p3p.sh
2022-09-06 00:41:57: PID: 29681: automatische Umschaltung aktiv (LV1) at 16 u1p3pswitch u1p3p.sh
2022-09-06 00:41:57: PID: 29681: Zeit zum abfragen aller Werte 5 Sekunden (LV1) at 176 main /var/www/html/openWB/regel.sh
2022-09-06 00:41:56: PID: 29681: chargestatlp1 0 chargestatlp2 0 chargestatlp3 0 (LV1) at 1300 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: plugstatlp1 0 plugstatlp2 0 plugstatlp3 0 (LV1) at 1299 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: lp1enabled 1 lp2enabled 1 lp3enabled 1 (LV1) at 1298 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: EVU 1:V/-1A 2: V/-1A 3: V/2A (LV1) at 1297 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: lla3 0 llv3 234.7 llas13 0 llas23  soclp1 0 soclp2 0 (LV1) at 1296 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: lla2 0 llv2 234.0 llas12 0 llas22  sofortll 16 hausverbrauch 1310 wattbezug 0 uberschuss 0 (LV1) at 1295 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: lla1 0 llv1 235.2 llas11 0 llas21  mindestuberschuss 500 abschaltuberschuss -5 lademodus 2 (LV1) at 1294 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: pv1watt 0 pv2watt  pvwatt 0 ladeleistung 0 llalt 0 nachtladen 0 nachtladen 0 minimalA 6 maximalA 32 (LV1) at 1293 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29681: speicherleistung -1310 speichersoc 55 (LV1) at 1288 loadvars loadvars.sh
2022-09-06 00:41:56: PID: 29973: EVU RET: 0 (LV2) at 15 main modules/bezug_smashm/main.sh
2022-09-06 00:41:56: PID: 4345: legacy run server: Completed running command in 0.14s: ["modules.sma_shm.device","counter","3007889034"]
2022-09-06 00:41:56: PID: 4345: modules.sma_shm.device: Update complete
2022-09-06 00:41:56: PID: 4345: modules.sma_shm.device: All components updated
2022-09-06 00:41:56: PID: 4345: soc.modules.common.store._api: Saving CounterState(exported=26150679.5, power=-0.7, power_factors=[0.91, 0.439, 0.851], currents=[-1.337, -1.429, 2.107], powers=[-268.6, -105.0, 372.9], imported=17987440.2, voltages=[235.375, 235.595, 234.312], frequency=50.003)
2022-09-06 00:41:56: PID: 4345: modules.sma_shm.device: Beginning update
2022-09-06 00:41:56: PID: 4345: legacy run server: Received command ["modules.sma_shm.device","counter","3007889034"]
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
2022-09-06 00:41:53: PID: 29867: BattLeistung: -1310 (LV1) at 28 main modules/speicher_sbs25/main.sh
2022-09-06 00:41:53: PID: 29867: RET: 0 (LV2) at 24 main modules/speicher_sbs25/main.sh
2022-09-06 00:41:53: PID: 4345: legacy run server: Completed running command in 0.16s: ["modules.sma_sunny_boy.device","bat","192.168.178.101"]
2022-09-06 00:41:53: PID: 4345: soc.modules.common.store._api: Saving BatState(soc=55, imported=349621, exported=287094, power=-1310)
2022-09-06 00:41:53: PID: 4345: soc.modules.common.component_context: Update Komponente ['Sma Sunny Boy Speicher']
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.device: Start device reading {'componentNone': <modules.sma_sunny_boy.bat.SunnyBoyBat object at 0x7502d4b0>}
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Hybrid: None
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Version: None
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus weitere IPs: None, None, None
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Webbox: None
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Ip-Adresse: 192.168.178.101
2022-09-06 00:41:53: PID: 4345: legacy run server: Received command ["modules.sma_sunny_boy.device","bat","192.168.178.101"]
2022-09-06 00:41:53: PID: 29851: RET: 0 (LV2) at 12 main modules/wr_tripower9000/main.sh
2022-09-06 00:41:53: PID: 4345: legacy run server: WR 1 nach Korrektur: InverterState(power=-1310, exported=922957, currents=[0.0, 0.0, 0.0])
2022-09-06 00:41:53: PID: 4345: legacy run server: Completed running command in 0.51s: ["modules.sma_sunny_boy.device","inverter","192.168.178.101","0","192.168.178.102","192.168.178.103"
2022-09-06 00:41:53: PID: 4345: soc.modules.common.store._api: Saving InverterState(power=0, exported=15396759, currents=[0.0, 0.0, 0.0])
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.inverter: WR 192.168.178.103: InverterState(power=0, exported=56757, currents=[0.0, 0.0, 0.0]), DC Power True
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.inverter: WR 192.168.178.102: InverterState(power=0, exported=14417045, currents=[0.0, 0.0, 0.0]), DC Power True
2022-09-06 00:41:53: PID: 4345: modules.sma_sunny_boy.inverter: WR 192.168.178.101: InverterState(power=-1310, exported=922957, currents=[0.0, 0.0, 0.0]), DC Power False
2022-09-06 00:41:52: PID: 4345: soc.modules.common.component_context: Update Komponente ['Sma Sunny Boy/Tripower Wechselrichter']
2022-09-06 00:41:52: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Hybrid: 1
2022-09-06 00:41:52: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Version: 0
2022-09-06 00:41:52: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus weitere IPs: 192.168.178.102, 192.168.178.103, none
2022-09-06 00:41:52: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Webbox: 0
2022-09-06 00:41:52: PID: 4345: modules.sma_sunny_boy.device: SMA Modbus Ip-Adresse: 192.168.178.101
2022-09-06 00:41:52: PID: 4345: legacy run server: Log level changed WARNING -> DEBUG
2022-09-06 00:41:51: PID: 29681: **** Regulation loop start **** (LV1) at 70 main /var/www/html/openWB/regel.sh
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
2022-09-06 00:40:03: PID: 15212: ##### cron5min.sh finished ##### (LV0)
2022-09-06 00:40:01: PID: 15212: ##### cron5min.sh started ##### (LV0)
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
2022-09-06 00:39:03: PID: 5898: **** FATAL ********************************* (LV0)
2022-09-06 00:39:03: PID: 5898: **** FATAL Regulation loop needs 12 seconds (LV0)
2022-09-06 00:39:03: PID: 5898: **** FATAL ********************************* (LV0)
2022-09-06 00:38:59: PID: 4725: **** FATAL ********************************* (LV0)
2022-09-06 00:38:59: PID: 4725: **** FATAL Regulation loop needs 18 seconds (LV0)
2022-09-06 00:38:59: PID: 4725: **** FATAL ********************************* (LV0)
2022-09-06 00:38:56: PID: 6456: Pause nach Umschaltung: 2s (LV0)
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
2022-09-06 00:38:52: PID: 6079: Pause nach Umschaltung: 2s (LV0)
/var/www/html/openWB/modules/extopenwb/main.sh: Zeile 78: [: None: Ganzzahliger Ausdruck erwartet.
2022-09-06 00:38:39: at_reboot: 2022-09-06 00:38:39: boot done :-)
2022-09-06 00:38:39: at_reboot: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 127.0.1.1. Set the 'ServerName' directive globally to suppress this message
2022-09-06 00:38:38: at_reboot: fix upload limit...OS Stretch
2022-09-06 00:38:38: at_reboot: not activated, skipping
2022-09-06 00:38:38: at_reboot: etprovider...
2022-09-06 00:38:31: PID: 4592: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
2022-09-06 00:38:29: at_reboot: update broker...
2022-09-06 00:38:28: at_reboot: clear warning...
2022-09-06 00:38:28: at_reboot: 
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100    43    0     0  100    43      0    192 --:--:-- --:--:-- --:--:--   193
2022-09-06 00:38:28: at_reboot: Dload  Upload   Total   Spent    Left  Speed
2022-09-06 00:38:28: at_reboot: % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
2022-09-06 00:38:28: at_reboot: version...
2022-09-06 00:38:28: at_reboot: Successfully installed urllib3-1.26.9
2022-09-06 00:38:27: at_reboot: Installing collected packages: urllib3
2022-09-06 00:38:27: at_reboot: Using cached https://files.pythonhosted.org/packages/ec/03/062e6444ce4baf1eac17a6a0ebfe36bb1ad05e1df0e20b110de59c278498/urllib3-1.26.9-py2.py3-none-any.whl
2022-09-06 00:38:23: at_reboot: Collecting urllib3
2022-09-06 00:38:21: PID: 4510: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
2022-09-06 00:38:16: at_reboot: lxml installed...
2022-09-06 00:38:16: at_reboot: ipparser installed...
2022-09-06 00:38:16: at_reboot: jq installed...
2022-09-06 00:38:15: at_reboot: python requests installed...
2022-09-06 00:38:13: at_reboot: pymodbus installed...
2022-09-06 00:38:13: at_reboot: aiohttp installed...
2022-09-06 00:38:12: at_reboot: certifi installed...
2022-09-06 00:38:12: at_reboot: docopt installed...
2022-09-06 00:38:12: at_reboot: mqtt installed...
2022-09-06 00:38:11: at_reboot: packages 2...
2022-09-06 00:38:11: at_reboot: updating mosquitto config file
2022-09-06 00:38:11: at_reboot: mosquitto...
2022-09-06 00:38:11: at_reboot: cp: '/usr/share/zoneinfo/Europe/Berlin' and '/etc/localtime' are the same file
2022-09-06 00:38:11: at_reboot: timezone...
2022-09-06 00:38:11: at_reboot: 2022-09-06 00:38:11: PID: 4421: upgradeChargeLogs: upgrading charge logs done
2022-09-06 00:38:11: at_reboot: 2022-09-06 00:38:11: PID: 4421: upgradeChargeLogs: upgrading charge logs with a price of 0.1045 per kWh
2022-09-06 00:38:11: PID: 4422: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
2022-09-06 00:38:10: at_reboot: evdev for python3 installed...
2022-09-06 00:38:09: at_reboot: evdev for python2 installed...
2022-09-06 00:38:08: PID: 4345: legacy run server: Changing log level DEBUG -> WARNING
2022-09-06 00:38:08: at_reboot: packages 1...
2022-09-06 00:38:08: at_reboot: crontab 2...
2022-09-06 00:38:08: at_reboot: ...changed
2022-09-06 00:38:08: at_reboot: apache...
2022-09-06 00:38:08: at_reboot: LAN/WLAN...
2022-09-06 00:38:08: at_reboot: crontab 1...
2022-09-06 00:38:08: at_reboot: Starting legacy run server
2022-09-06 00:38:08: at_reboot: legacy run server...
2022-09-06 00:38:08: at_reboot: mqtt handler...
2022-09-06 00:38:08: at_reboot: starting smarthomemq handler
2022-09-06 00:38:08: at_reboot: smarthome handler...
2022-09-06 00:38:08: at_reboot: deleting browser cache
2022-09-06 00:38:08: at_reboot: already up to date
2022-09-06 00:38:08: at_reboot: display...
2022-09-06 00:38:07: at_reboot: modbus server...
2022-09-06 00:38:03: at_reboot: triginit...
2022-09-06 00:38:03: at_reboot: Ramdisk init done.
2022-09-06 00:38:03: at_reboot: Trigger update of logfiles...
2022-09-06 00:38:01: PID: 4171: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
2022-09-06 00:37:58: at_reboot: Initializing Ramdisk /var/www/html/openWB/ramdisk
2022-09-06 00:37:58: at_reboot: Config file Update done.
2022-09-06 00:37:53: at_reboot: Updating /var/www/html/openWB/openwb.conf...
2022-09-06 00:37:52: PID: 3305: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
2022-09-06 00:37:47: at_reboot: loading config
2022-09-06 00:37:47: at_reboot: atreboot.sh started
2022-09-06 00:37:42: PID: 3192: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
2022-09-06 00:37:32: PID: 3180: Update in progress (LV0) at 36 main /var/www/html/openWB/regel.sh
Ist auch auf dem zweiten Ladepunkt die aktuelle Nightly? Ich habe den Fehler gestern mittag korrigiert. Nach dem Update bitte nochmal ein Reboot des Ladepunkts durchführen.
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Rückmeldungen Nightly 1.9.276

Beitrag von LenaK »

blueberry63 hat geschrieben: Di Sep 06, 2022 9:03 am Ich habe das Regelintervall mal auf "langsam" umgestellt. Die Meldungen im Log kommen aber immer noch, jetzt allerdings mit höherer Laufzeit:

Code: Alles auswählen

2022-09-06 10:58:57: PID: 24954: **** FATAL ********************************* (LV0)
2022-09-06 10:58:57: PID: 24954: **** FATAL Regulation loop needs 16 seconds (LV0)
2022-09-06 10:58:57: PID: 24954: **** FATAL ********************************* (LV0)
2022-09-06 10:58:35: PID: 23602: **** FATAL ********************************* (LV0)
2022-09-06 10:58:35: PID: 23602: **** FATAL Regulation loop needs 14 seconds (LV0)
2022-09-06 10:58:35: PID: 23602: **** FATAL ********************************* (LV0)
2022-09-06 10:58:15: PID: 22240: **** FATAL ********************************* (LV0)
2022-09-06 10:58:15: PID: 22240: **** FATAL Regulation loop needs 14 seconds (LV0)
2022-09-06 10:58:15: PID: 22240: **** FATAL ********************************* (LV0)
2022-09-06 10:57:55: PID: 20857: **** FATAL ********************************* (LV0)
2022-09-06 10:57:55: PID: 20857: **** FATAL Regulation loop needs 14 seconds (LV0)
2022-09-06 10:57:55: PID: 20857: **** FATAL ********************************* (LV0)
2022-09-06 10:57:43: PID: 19512: **** FATAL ********************************* (LV0)
2022-09-06 10:57:43: PID: 19512: **** FATAL Regulation loop needs 22 seconds (LV0)
2022-09-06 10:57:43: PID: 19512: **** FATAL ********************************* (LV0)
2022-09-06 10:57:17: PID: 18152: **** FATAL ********************************* (LV0)
2022-09-06 10:57:17: PID: 18152: **** FATAL Regulation loop needs 16 seconds (LV0)
2022-09-06 10:57:17: PID: 18152: **** FATAL ********************************* (LV0)
2022-09-06 10:56:58: PID: 16740: **** FATAL ********************************* (LV0)
2022-09-06 10:56:58: PID: 16740: **** FATAL Regulation loop needs 18 seconds (LV0)
2022-09-06 10:56:58: PID: 16740: **** FATAL ********************************* (LV0)
2022-09-06 10:56:41: PID: 15396: **** FATAL ********************************* (LV0)
2022-09-06 10:56:41: PID: 15396: **** FATAL Regulation loop needs 21 seconds (LV0)
2022-09-06 10:56:41: PID: 15396: **** FATAL ********************************* (LV0)
2022-09-06 10:56:15: PID: 14021: **** FATAL ********************************* (LV0)
2022-09-06 10:56:15: PID: 14021: **** FATAL Regulation loop needs 15 seconds (LV0)
2022-09-06 10:56:15: PID: 14021: **** FATAL ********************************* (LV0)
Mir ist noch etwas aufgefallen: ich greife noch von anderer Stelle per Modbus auf den SMA Wechselrichter zu und dort funktioniert der Abruf auch nicht mehr zu 100% (es werden nur noch einzelne Daten empfangen). Alles sehr komisch...

Gru0
Blueberry63
Welche Version verwendest Du genau?
blueberry63
Beiträge: 79
Registriert: Sa Jan 11, 2020 5:50 pm

Re: Rückmeldungen Nightly 1.9.276

Beitrag von blueberry63 »

... die Nightly von gestern Nachmittag: 1.9.276 (2022-09-05 16:04:00 +0200 [cab8dd98] )
Dr. Mad
Beiträge: 19
Registriert: Do Okt 14, 2021 7:45 am
Wohnort: Stuttgart

Re: Rückmeldungen Nightly 1.9.276

Beitrag von Dr. Mad »

LenaK hat geschrieben: Di Sep 06, 2022 11:21 am Ist auch auf dem zweiten Ladepunkt die aktuelle Nightly? Ich habe den Fehler gestern mittag korrigiert. Nach dem Update bitte nochmal ein Reboot des Ladepunkts durchführen.
Ja, wurde auf der zweiten openWB automatisch mit aktualisiert. Ich mache heute abend, wenn ich wieder zu hause bin, nochmal ein Update & Reboot von beiden openWBs.
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Rückmeldungen Nightly 1.9.276

Beitrag von LenaK »

blueberry63 hat geschrieben: Di Sep 06, 2022 1:30 pm ... die Nightly von gestern Nachmittag: 1.9.276 (2022-09-05 16:04:00 +0200 [cab8dd98] )
Dann ist die Änderung enthalten. Hast du nochmal einen Neustart gemacht, damit alle offenen Modbus-Verbindungen geschlossen werden?
MadMax219
Beiträge: 31
Registriert: Fr Dez 03, 2021 12:27 am

Re: Rückmeldungen Nightly 1.9.276

Beitrag von MadMax219 »

LenaK hat geschrieben: Mo Sep 05, 2022 2:04 pm Ich habe den Connection-Contextmanager korrigiert. Evtl kann ein Neustart erforderlich sein, um alle offenen Modbus-Verbindungen zu schließen.
Vielen Dank für die schnelle Behebung.
Bei mir funktioniert es mit der 1.9.276 (2022-09-05 16:04:00 +0200 [cab8dd98] ) wieder.
Soll heißen, mein SMA Tripower antwortet wieder wie gewohnt auf (fast) alle Anfragen.
blueberry63
Beiträge: 79
Registriert: Sa Jan 11, 2020 5:50 pm

Re: Rückmeldungen Nightly 1.9.276

Beitrag von blueberry63 »

@Lena: Ja, ich habe nach dem Update einen Neustart gemacht.

Ich werde morgen mal den SMA Wechselrichter durchstarten. Mal sehen, was dann passiert.

Gruß
Blueberry63
Antworten