Hausverbrauch steigt mit PV Produktion

[Loewuppel]

Hallo,
nach der Einbindung zweier neuer PV-Anlagen in SolarLog wächst der Hausverbrauch im Graphen und bei den Energiemengen mit der PV-Produktion.
Im Echtzeit-Ringdiagramm stimmt die Darstellung der Daten noch.
Auch im OpenWB-Status im Sektor EVU stimmt die Angabe der Gesamtleistung und die „Flussrichtung“ Exp./Imp.
Dennoch scheint es ja ein Vorzeichenproblem zu geben bei der Hausverbrauchsberechnung.
Woran kann das liegen?
Danke für Eure Tips dazu.
Grüße
Bernhard

Installiert ist die neueste Nightly.
EVU- und PV-Modul jeweils SolarLog.

[Loewuppel]

Hier noch ein Debug-Log-Ausschnitt aus dem abgebildeten Zeitraum…sieht irgendwie nicht gut aus

Code: Alles auswählen

 2023-07-11 14:10:20: PID: 6644: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:10:10: PID: 5048: **** FATAL ********************************* (LV0)
2023-07-11 14:10:10: PID: 5048: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:10:10: PID: 5048: **** FATAL ********************************* (LV0)
2023-07-11 14:10:04: PID: 5050: ##### cron5min.sh finished ##### (LV0)
2023-07-11 14:10:03:  Load: 1.44 1.45 1.65
2023-07-11 14:10:02: PID: 5282: Starting OpenWB services (LV0)
2023-07-11 14:10:02: PID: 5050: ##### cron5min.sh started ##### (LV0)
2023-07-11 14:09:59: PID: 3730: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:09:49: PID: 2442: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:09:39: PID: 1095: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:09:29: PID: 32237: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:09:19: PID: 30950: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:09:09: PID: 29548: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:08:59: PID: 28218: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:08:49: PID: 26929: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:08:39: PID: 25641: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:08:29: PID: 24354: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:08:20: PID: 23059: **** FATAL ********************************* (LV0)
2023-07-11 14:08:20: PID: 23059: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:08:20: PID: 23059: **** FATAL ********************************* (LV0)
2023-07-11 14:08:09: PID: 21753: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:07:58: PID: 20441: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:07:48: PID: 19147: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:07:29: PID: 16624: **** FATAL ********************************* (LV0)
2023-07-11 14:07:29: PID: 16624: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:07:29: PID: 16624: **** FATAL ********************************* (LV0)
2023-07-11 14:07:18: PID: 15336: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:07:08: PID: 14037: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:07:00: PID: 12715: **** FATAL ********************************* (LV0)
2023-07-11 14:07:00: PID: 12715: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:07:00: PID: 12715: **** FATAL ********************************* (LV0)
2023-07-11 14:06:49: PID: 11424: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:06:39: PID: 10133: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:06:30: PID: 8840: **** FATAL ********************************* (LV0)
2023-07-11 14:06:30: PID: 8840: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:06:30: PID: 8840: **** FATAL ********************************* (LV0)
2023-07-11 14:06:19: PID: 7547: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:06:09: PID: 6242: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:05:58: PID: 4929: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:05:48: PID: 3640: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:05:38: PID: 2349: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:05:29: PID: 990: **** FATAL ********************************* (LV0)
2023-07-11 14:05:29: PID: 990: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:05:29: PID: 990: **** FATAL ********************************* (LV0)
2023-07-11 14:05:18: PID: 32134: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:05:08: PID: 30546: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:05:02: PID: 30554: ##### cron5min.sh finished ##### (LV0)
2023-07-11 14:05:01:  Load: 1.69 1.62 1.78
2023-07-11 14:05:01: PID: 30795: Starting OpenWB services (LV0)
2023-07-11 14:05:00: PID: 30554: ##### cron5min.sh started ##### (LV0)
2023-07-11 14:05:00: PID: 29220: **** FATAL ********************************* (LV0)
2023-07-11 14:05:00: PID: 29220: **** FATAL Regulation loop needs 9 seconds (LV0)
2023-07-11 14:05:00: PID: 29220: **** FATAL ********************************* (LV0)
2023-07-11 14:04:40: PID: 26641: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:04:30: PID: 25349: **** WARNING **** Regulation loop needs 8 seconds (LV0)
2023-07-11 14:03:59: PID: 21557: **** WARNING **** Regulation loop needs 8 seconds (LV0)

[Loewuppel]

Und hier noch ein Ausschnitt ohne gehäufte Warnmeldungen:

Code: Alles auswählen

 2023-07-11 17:55:04: PID: 3906: uberschuss 10659 wattbezug -10451 ladestatus 1 llsoll 6 pvwatt -14632 mindestuberschussphasen 600 wattkombiniert 10659 schaltschwelle 230 (LV2) at 586 main /var/www/html/openWB/regel.sh
2023-07-11 17:55:04: PID: 3906: anzahlphasen 1 (LV1) at 585 main /var/www/html/openWB/regel.sh
2023-07-11 17:55:04: PID: 3906: Timing Umschaltung: 480 / 480 (LV1) at 17 u1p3pswitch u1p3p.sh
2023-07-11 17:55:04: PID: 3906: automatische Umschaltung aktiv (LV1) at 16 u1p3pswitch u1p3p.sh
2023-07-11 17:55:04: PID: 3906: Zeit zum abfragen aller Werte 4 Sekunden (LV1) at 186 main /var/www/html/openWB/regel.sh
2023-07-11 17:55:03: PID: 3906: chargestatlp1 0 chargestatlp2 0 chargestatlp3 0 (LV1) at 1274 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: plugstatlp1 0 plugstatlp2 0 plugstatlp3 0 (LV1) at 1273 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: lp1enabled 1 lp2enabled 1 lp3enabled 1 (LV1) at 1272 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: EVU 1:V/0A 2: V/0A 3: V/0A (LV1) at 1271 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: lla3 0 llv3 232.3 llas13  llas23  soclp1 76 soclp2  (LV1) at 1270 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: lla2 0 llv2 232.2 llas12  llas22  sofortll 16 hausverbrauch 4181 wattbezug -10451 uberschuss 10659 (LV1) at 1269 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: lla1 0 llv1 232.2 llas11  llas21  mindestuberschuss 600 abschaltuberschuss -200 lademodus 2 (LV1) at 1268 loadvars loadvars.sh
2023-07-11 17:55:03: PID: 3906: pv1watt -14632 pv2watt  pvwatt -14632 ladeleistung 0 llalt 6 nachtladen 0 nachtladen 0 minimalA 6 maximalA 32 (LV1) at 1267 loadvars loadvars.sh
2023-07-11 17:55:02: PID: 4415: RET: 0 (LV2) at 19 main modules/bezug_solarlog/main.sh
2023-07-11 17:55:02: PID: 17121: legacy run server: Completed running command in 0.14s: ["modules.devices.solar_log.device","counter","192.168.137.21","0"]
2023-07-11 17:55:02: PID: 17121: soc.modules.common.store._api: Saving CounterState(power_factors=[0.0, 0.0, 0.0], power=-10451, voltages=[230.0, 230.0, 230.0], imported=41793609.22027778, frequency=50, exported=48332433.69121804, currents=[0.0, 0.0, 0.0], powers=[0.0, 0.0, 0.0])
2023-07-11 17:55:02: PID: 17121: modules.common.simcount._simcount: imported: 0 Wh, exported: 23.2393 Wh, new state: SimCounterState(imported=41793609.22027778, exported=48332433.69121804, timestamp=1689090902.8932831, power=-10451)
2023-07-11 17:55:02: PID: 17121: modules.common.simcount._calculate: power did not change sign. Total energy: -23.2393
2023-07-11 17:55:02: PID: 17121: modules.common.simcount._calculate: time passed: 0.00222364, power1: -10451, power2: -10451
2023-07-11 17:55:02: PID: 17121: modules.common.simcount._simcount: Previous state: SimCounterState(imported=41793609.22027778, exported=48332410.45194445, timestamp=1689090894.888175, power=-10451.0)
2023-07-11 17:55:02: PID: 17121: soc.modules.common.store._api: Saving InverterState(exported=42336131.0, dc_power=None, currents=[0.0, 0.0, 0.0], power=-14632.0)
2023-07-11 17:55:02: PID: 17121: soc.modules.common.req: Get-Response: {"801":{"170":{"100":"11.07.23 17:54:36","101":14632,"102":15101,"103":232,"104":580,"105":335806,"106":298308,"107":3418246,"108":19769814,"109":42336131,"110":4181,"111":94723,"112":84117,"113":1044623,"114":13465818,"115":75042229,"116":13650}}}
2023-07-11 17:55:02: PID: 17121: requests.packages.urllib3.connectionpool: http://192.168.137.21:80 "POST /getjp HTTP/1.1" 200 None
2023-07-11 17:55:02: PID: 17121: requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): 192.168.137.21:80
2023-07-11 17:55:02: PID: 17121: modules.devices.solar_log.device: Solar-Log ip_address: 192.168.137.21
2023-07-11 17:55:02: PID: 17121: legacy run server: Received command ["modules.devices.solar_log.device","counter","192.168.137.21","0"]
2023-07-11 17:55:02: PID: 4415: Bezug Solarlog Speicher : 0 (LV2) at 14 main modules/bezug_solarlog/main.sh
2023-07-11 17:55:02: PID: 4415: Bezug Solarlog IP: 192.168.137.21 (LV2) at 13 main modules/bezug_solarlog/main.sh
2023-07-11 17:55:02: PID: 3897: ##### cron5min.sh finished ##### (LV0) at 313 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:01: PID: 17121: legacy run server: Completed running command in 0.10s: ["modules.devices.solar_log.device","inverter","192.168.137.21","0"]
2023-07-11 17:55:01: PID: 17121: soc.modules.common.store._api: Saving InverterState(exported=42336131.0, dc_power=None, currents=[0.0, 0.0, 0.0], power=-14632.0)
2023-07-11 17:55:01: PID: 17121: soc.modules.common.req: Get-Response: {"801":{"170":{"100":"11.07.23 17:54:36","101":14632,"102":15101,"103":232,"104":580,"105":335806,"106":298308,"107":3418246,"108":19769814,"109":42336131,"110":4181,"111":94723,"112":84117,"113":1044623,"114":13465818,"115":75042229,"116":13650}}}
2023-07-11 17:55:01: PID: 17121: requests.packages.urllib3.connectionpool: http://192.168.137.21:80 "POST /getjp HTTP/1.1" 200 None
2023-07-11 17:55:01: PID: 3897: logfile cleanup triggered (LV1) at 310 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:01: PID: 17121: requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): 192.168.137.21:80
2023-07-11 17:55:01: PID: 17121: soc.modules.common.component_context: Update Komponente ['Solar-Log Wechselrichter']
2023-07-11 17:55:01: PID: 17121: modules.devices.solar_log.device: Solar-Log ip_address: 192.168.137.21
2023-07-11 17:55:01: PID: 17121: legacy run server: Received command ["modules.devices.solar_log.device","inverter","192.168.137.21","0"]
2023-07-11 17:55:01:  Load: 3.48 2.15 1.77
2023-07-11 17:55:01: PID: 3897: pingcheck configured; starting (LV1) at 300 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:01: PID: 4144: push buttons disabled (LV1) at 41 pushButtonsSetup /var/www/html/openWB/runs/pushButtons/pushButtonsHelper.sh
2023-07-11 17:55:01: PID: 4144: rse disabled (LV1) at 41 rseSetup /var/www/html/openWB/runs/rse/rseHelper.sh
2023-07-11 17:55:01: PID: 4144: checking network setup (LV1) at 103 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: external openWB, daemon mode or socket mode not configured (LV1) at 97 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: legacy run server is already running (LV1) at 60 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: Starting legacy run server... (LV1) at 54 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: smart home handler is already running (LV1) at 42 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: smart home handler... (LV1) at 39 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: mqtt handler is already running (LV1) at 33 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: Starting MQTT handler... (LV1) at 31 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: modbus tcp server already running (LV1) at 25 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: Starting modbus server... (LV1) at 23 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 4144: Starting OpenWB services (LV0) at 21 start /var/www/html/openWB/runs/services.sh
2023-07-11 17:55:00: PID: 3897: current ip: 192.168.137.56 (LV1) at 293 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:00: PID: 3897: updating daily yield stats (LV1) at 164 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:00: PID: 3897: electricity provider not set up; skipping price update (LV2) at 160 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:00: PID: 3897: Netzschutz konfiguriert; aktuelle Frequenz: 4995 (LV1) at 109 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:00: PID: 3897: daily csv updated: /var/www/html/openWB/web/logging/data/daily/20230711.csv (LV1) at 101 main /var/www/html/openWB/runs/cron5min.sh
2023-07-11 17:55:00: PID: 3906: **** Regulation loop start **** (LV1) at 77 main /var/www/html/openWB/regel.sh

[Loewuppel]

@LenaK aus dem Support hat das Problem mit einem Nightly-Update gelöst. Jetzt stimmt der Hausverbrauch wieder.
Danke und Gruß