Gerät schaltet nicht ab obwohl keine Überschussenergie vorhanden, ständiger Toogle on/off

[Lausbua]

Hallo,

habe seit geraumer Zeit SAE in Verbindung mit einem Stufenschalter in Betrieb.
Mir ist jetzt aufgefallen das mein Gerät (2 Stufen 4000W/2000W) nicht abschaltet obwohl keine Überschussenergie vorhanden ist.
Der Energiebedarf wird dem Hausspeicher entnommen.
Das ganze läuft dann bis zum Ende vom Zeitplan und danach schaltet das Gerät ab. Im MQTT Explorer sehe im CONTROL Topic das der Wert von on zwischen false/true hin und hersprint.

Die Ampel auf der Startpage vom Gerät blinkt gelb.

Was könnte das Problem sein?

[camueller]

Der Stufenschalter wird vermutlich nicht von vielen Usern genutzt. Wenn ich mich recht erinnere, gab es seit dem letzten Release Fixes, die sich potentiell auch auf den Stufenschalter auswirken. Deshalb würde ich Dich bitte, auf eine modifizierte 2.3.0-Version zu wechseln, die alle dieses Fixes beinhaltet:

https://drive.google.com/file/d/1gBM--oE0V0kRSkFOqZEsriPLQXJoR2qx/view?usp=share_link

Wenn damit der Fehler immer noch auftritt, wäre es gut, wenn Du mir Log-Files verfügbar machen könntest, damit ich das analysieren kann. Ich würde gerne in den nächsten Wochen eine neue Version releasen und bis dahin das Problem fixen wollen, falls vorhanden.

[Lausbua]

Habe soeben die modifizierte 2.3.0 von Google Drive aufgespielt.

Habe mein Loglevel wieder auf debug erhöht und kann im Fehlerfall dann mit einem Logfile dienen.

[Lausbua]

Hallo Axel, leider besteht das Problem mit der Version inkl. Fixes auch.
Der damit gesteuerte Boiler bezieht jedoch nicht immer Energie auch selbst wenn ein Überschuss vorhanden ist. Erkennt man daran das eine Freigabe z.B. für 2000W vorliegt aber laut Metering kein Bezug stattfindet. Am Boiler selbst befindet sich ein Thermostat der über 65 Grad abschaltet und erst nach absinken auf 45 Grad wieder freigibt. Daher kann teilweise kein sofortiger Bezug erkennbar sein.

Im Log erkenne ich das um 16:00 Uhr herum der Überschuss nicht mehr ausgereicht hat. Der Ertrag hat hier geschwankt. Mehrmals wird aktiviert/deaktiviert sowie die Leistung von 4000W zu 2000W reduziert. Überschuss war bis ca. 16:35 Uhr verfügbar.

Warum dann um 16:36 Uhr eine Freigabe für 2000W kommt kann ich mir nicht erklären. Der letzte Ausschaltbefehl um 18:00 Uhr erfolgt auf Grund vom Zeitplan - dieser läuft nur bis 18:00 Uhr.

Um 16:36 Uhr war definitiv kein Überschuss mehr in Höhe von 2000W vorhanden, der Boiler hätte den Speicher entleert. Da der Thermostat erst wieder um 17:45 Uhr aktiviert hat, sieht man die letzten 15 Minuten bis zum Ende vom Zeitplan den Energiebezug von 1839 Watt.

Vorssichtshalber hänge ich noch einen Screenshoot von meinen Zeitplan an.

[camueller]

Der Zeitplan sieht gut aus.

Allerdings stimmt etwas mit Deinem Zähler nicht - das Register 8210 liefert zumindest nach dem Einschalten um 16:36:15 immer 0 und deshalb meldet der SAE dem HM auch eine Leistungsaufnahme von 0:

2023-10-22 16:36:15,637 DEBUG [http-nio-8080-exec-8] d.a.s.s.w.SempController [SempController.java:300] F-xxxxxxxx-000000000001-00: Received control request: on=true, recommendedPowerConsumption=2000W

2023-10-22 16:36:15,641 DEBUG [http-nio-8080-exec-8] d.a.s.a.Appliance [Appliance.java:440] F-xxxxxxxx-000000000001-00: Setting appliance state to ON
2023-10-22 16:36:15,650 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:234] F-xxxxxxxx-000000000001-00: Setting power to 2000W
2023-10-22 16:36:15,655 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:226] F-xxxxxxxx-000000000001-00: Setting wrapped control switch 1 to on
2023-10-22 16:36:15,668 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:226] F-xxxxxxxx-000000000001-00: Setting wrapped control switch 2 to off

2023-10-22 16:36:57,086 DEBUG [http-nio-8080-exec-3] d.a.s.s.w.SempController [SempController.java:335] F-xxxxxxxx-000000000001-00: Reporting device status from control
2023-10-22 16:36:57,091 DEBUG [http-nio-8080-exec-3] d.a.s.s.w.SempController [SempController.java:344] F-xxxxxxxx-000000000001-00: DeviceStatus{eMSignalsAccepted=true, status=Off, errorCode=null}
2023-10-22 16:36:57,096 DEBUG [http-nio-8080-exec-3] d.a.s.s.w.SempController [SempController.java:350] F-xxxxxxxx-000000000001-00: Reporting power info from meter.
2023-10-22 16:36:57,100 DEBUG [http-nio-8080-exec-3] d.a.s.s.w.SempController [SempController.java:364] F-xxxxxxxx-000000000001-00: PowerInfo{averagePower=0, minPower=null, maxPower=null, timestamp=0, averagingInterval=60}

2023-10-22 16:37:55,585 DEBUG [http-nio-8080-exec-9] d.a.s.s.w.SempController [SempController.java:335] F-xxxxxxxx-000000000001-00: Reporting device status from control
2023-10-22 16:37:55,590 DEBUG [http-nio-8080-exec-9] d.a.s.s.w.SempController [SempController.java:344] F-xxxxxxxx-000000000001-00: DeviceStatus{eMSignalsAccepted=true, status=Off, errorCode=null}
2023-10-22 16:37:55,594 DEBUG [http-nio-8080-exec-9] d.a.s.s.w.SempController [SempController.java:350] F-xxxxxxxx-000000000001-00: Reporting power info from meter.
2023-10-22 16:37:55,598 DEBUG [http-nio-8080-exec-9] d.a.s.s.w.SempController [SempController.java:364] F-xxxxxxxx-000000000001-00: PowerInfo{averagePower=0, minPower=null, maxPower=null, timestamp=0, averagingInterval=60}

[Lausbua]

Ja, das liegt daran das am Gerät sich ein Thermostat befindet. Erst um 17:45 Uhr hat der Thermostat erneut freigeben und den Bezug von 1872W gemeldet. Der Bedarf wurde hier vom Hausspeicher abgedeckt bis um 18:00 Uhr, um 18:00 Uhr wurde durch den Zeitplan abgeschaltet.

2023-10-22 17:45:55,966 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:335] F-xxxxxxxx-000000000001-00: Reporting device status from control
2023-10-22 17:45:55,971 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:344] F-xxxxxxxx-000000000001-00: DeviceStatus{eMSignalsAccepted=true, status=Off, errorCode=null}
2023-10-22 17:45:55,975 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:350] F-xxxxxxxx-000000000001-00: Reporting power info from meter.
2023-10-22 17:45:55,981 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:364] F-xxxxxxxx-000000000001-00: PowerInfo{averagePower=1872, minPower=null, maxPower=null, timestamp=0, averagingInterval=60}

[camueller]

Thermostat hin oder her - der SAE muss IMMER die korrekte Leistung ermitteln können. Solange das nicht der Fall ist, brauchen wir andere potentielle Fehler nicht analysieren.

[Lausbua]

Der angeschlossene Modbuszähler liefert jederzeit die korrekte Leistung und funktioniert einwandfrei.
Sollte dennoch der Stufenschalter bei einem nicht vorhandenen Überschuss von weniger wie 2000W nicht abschalten unabhängig welche Leistung der Zähler meldet? Es erfolgte mit Einschalten um 16:36 Uhr bis zum Ende vom Zeitplan keine weitere Aktion. Ich vermisse einen Abschaltbefehl vor dem Ende vom Zeitplan.

[camueller]

Ah, das Thermostat sort dafür, dass der Boiler ausgeschaltet bleibt trotz vorangegangenem Einschaltbefehl.

Zumindest in dem oben von mir gequoteten Log braucht es auch keinen Ausschaltbefehlt, weil das Gerät ja überhaupt nicht eingeschaltet wurde. Vielleicht wäre es besser, wenn wir ein Log hätten, wo das Gerät tatsächlich eingeschaltet war und nicht ausgeschaltet wurde.

[Lausbua]

Hat sich die Art der Regelung beim Stufenschalter geändert? Die Konfiguration hat bis dahin funktioniert. Würde es funktionieren wenn der gemessene Verbrauch größer 0 Watt wäre? Ich würde dazu einfach die Schütz (sind mehrere) mit auf den Zähler klemmen, diese haben im angezogenen Zustand einen Verbrauch von wenigen Watt (~5-10 Watt). Somit wäre bei keinem Überschuss die Abschaltung da. Das könnte ich allerdings erst in einer Woche testen, bis dahin habe ich den Stufenschalter in SAE umkonfiguriert zum Schalter mit Zeitplan nach Laufzeit und nicht Leistung.

[camueller]

Hat sich die Art der Regelung beim Stufenschalter geändert?

Der Stufenschalter ist lediglich ein Verbraucher mit variabler Leistungsaufnahme (ich hoffe, dass Du die min. Leistung im SAE für das Gerät konfiguriert hast - ist das so???). Aber der SAE ist nur das Gateway, der Home Manager macht die Regelung!

Die Konfiguration hat bis dahin funktioniert.

Wenn das so ist, kannst Du ja einfach die "funktionierende" Version des SAE einspielen und alles ist gut.

Das könnte ich allerdings erst in einer Woche testen, bis dahin habe ich den Stufenschalter in SAE umkonfiguriert zum Schalter mit Zeitplan nach Laufzeit und nicht Leistung.

Ich kann Dir jetzt schon sagen, dass das nicht funktionieren wird: Verbraucher mit variabler Leistungsaufnahme müssen eine Arbeitsanforderung (also Wh) melden und keine Laufzeit (Sekunden). Als ich den Stufenschalter implementiert habe, hatte ich das getestet. Ich denke nicht, dass Umbauten Deines Setups das Problem lösen, solange das Problem selbst nicht richtig verstanden ist.

Aber Du hast meine letzte Frage noch nicht beantwortet: Hast Du ein Log, aus dem hervorgeht, dass der HM keinen Abschaltbefehl sendet, obwohl das Gerät Leistung aufnimmt trotz nicht vorhandenem Überschuss? In dem geposteten Log ist zwar ersichtlich, dass kein Abschaltbefehl bis zum Ende des Zeitfensters kommt, aber wegen des Thermostats wird ja effektiv keine Leistung aufgenommen und die nicht erfolgte Abschaltung hat keine Auswirkung.

[Lausbua]

Entschuldige meine verspätete Antwort, bin jetzt wieder im Lande. Aus dem Log wäre der Fall der Nichtabschaltung ab 17:45 Uhr zu beobachten. Die vom Zähler bezogene Leistung waren 1898 W.

2023-10-22 17:45:05,054 DEBUG [Timer-0] d.a.s.m.PollPowerMeter [PollPowerMeter.java:127] F-xxxxxxxx-000000000001-00: Calculating diffEnergy from power: diffEnergy=0kWh currentPower=0W previousPowerTimestamp=2023-10-22T17:44:44.970688 currentPowerTimestamp=2023-10-22T17:45:04.970689 diffTime=20000ms
2023-10-22 17:45:24,697 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.ModbusElectricityMeter [ModbusElectricityMeter.java:192] F-xxxxxxxx-000000000001-00: Start energy meter ...
2023-10-22 17:45:24,705 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.ModbusSlave [ModbusSlave.java:77] F-xxxxxxxx-000000000001-00: Connecting to modbus 1@127.0.0.1:502
2023-10-22 17:45:24,758 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.e.ReadInputRegisterExecutor [ReadInputRegisterExecutor.java:56] F-xxxxxxxx-000000000001-00: Input register=8210 value=[18068, 22528]
2023-10-22 17:45:24,761 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.t.FloatValueTransformer [FloatValueTransformer.java:44] F-xxxxxxxx-000000000001-00: transformed value=1898.8000000000002
2023-10-22 17:45:24,769 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.PollPowerMeter [PollPowerMeter.java:147] F-xxxxxxxx-000000000001-00: Start energy counter: 5.92036kWh
2023-10-22 17:45:24,772 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.ModbusElectricityMeter [ModbusElectricityMeter.java:200] F-xxxxxxxx-000000000001-00: Current energy meter value: 5.920356757694448kWh
2023-10-22 17:45:24,838 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-EnergyRequest-7] d.a.s.m.ModbusElectricityMeter [ModbusElectricityMeter.java:205] F-xxxxxxxx-000000000001-00: Stop energy meter ...
2023-10-22 17:45:55,966 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:335] F-xxxxxxxx-000000000001-00: Reporting device status from control
2023-10-22 17:45:55,971 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:344] F-xxxxxxxx-000000000001-00: DeviceStatus{eMSignalsAccepted=true, status=Off, errorCode=null}
2023-10-22 17:45:55,975 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:350] F-xxxxxxxx-000000000001-00: Reporting power info from meter.
2023-10-22 17:45:55,981 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:364] F-xxxxxxxx-000000000001-00: PowerInfo{averagePower=1872, minPower=null, maxPower=null, timestamp=0, averagingInterval=60}

Der Bezug erfolgte bis 18:00 Uhr obwohl kein Überschuss vorhanden war. Die Leistung wurde dem Hausspeicher/Batterie entnommen.
Um 18:00 Uhr war der Zeitplan zu Ende und es erfolgte die Abschaltung:

2023-10-22 18:00:04,561 DEBUG [Timer-0] d.a.s.a.Appliance [Appliance.java:440] F-xxxxxxxx-000000000001-00: Switching off since timeframe interval was deactivated
2023-10-22 18:00:04,570 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:234] F-xxxxxxxx-000000000001-00: Setting power to 0W
2023-10-22 18:00:04,574 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:226] F-xxxxxxxx-000000000001-00: Setting wrapped control switch 1 to off
2023-10-22 18:00:04,577 DEBUG [Timer-0] d.a.s.s.TimeframeIntervalHandler [TimeframeIntervalHandler.java:301] F-xxxxxxxx-000000000001-00: Notifying TimeframeIntervalChangedListener EnergyRequest DISABLED/0Wh/30080Wh
2023-10-22 18:00:04,585 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:226] F-xxxxxxxx-000000000001-00: Setting wrapped control switch 2 to off
2023-10-22 18:00:04,595 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-Switch-6] d.a.s.c.Switch [Switch.java:147] F-xxxxxxxx-000000000001-00: Switching off GPIO 5
2023-10-22 18:00:04,624 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-Switch-7] d.a.s.c.Switch [Switch.java:147] F-xxxxxxxx-000000000001-00: Switching off GPIO 6

Während meiner Abwesenheit funktionierte die Konfiguration als Schalter (nicht Stufenschalter) einwandfrei.

[camueller]

Aus dem Log wäre der Fall der Nichtabschaltung ab 17:45 Uhr zu beobachten. Die vom Zähler bezogene Leistung waren 1898 W.

Der SAE hat zu diesem Zeitpunkt allerdings an den SHM gemeldet, dass das Geräte abschaltet ist (status=Off), was falsch ist.

2023-10-22 17:45:55,971 DEBUG [http-nio-8080-exec-1] d.a.s.s.w.SempController [SempController.java:344] F-xxxxxxxx-000000000001-00: DeviceStatus{eMSignalsAccepted=true, status=Off, errorCode=null}

Also braucht der SHM ja keinen Abschaltbefehl zu senden. Übrigens werden Verbräuche vom SHM und Sunny Portal nicht gewertet, wenn das Gerät nicht eingeschaltet ist, d.h. um 17:45 wirst Du keinen Verbauch im Sunny Portal für das Gerät sehen und in der Tagessumme fehlt er auch.

Das letzte Mal wurde status=On gemeldet um 16:16:56:

2023-10-22 16:16:56,256 DEBUG [http-nio-8080-exec-2] d.a.s.s.w.SempController [SempController.java:344] F-xxxxxxxx-000000000001-00: DeviceStatus{eMSignalsAccepted=true, status=On, errorCode=null}

Danach kam ein Einschaltbefehl mit 2000W:

2023-10-22 16:17:15,833 DEBUG [http-nio-8080-exec-7] d.a.s.s.w.SempController [SempController.java:300] F-xxxxxxxx-000000000001-00: Received control request: on=true, recommendedPowerConsumption=2000W
2023-10-22 16:17:15,837 DEBUG [http-nio-8080-exec-7] d.a.s.a.Appliance [Appliance.java:440] F-xxxxxxxx-000000000001-00: Setting appliance state to ON
2023-10-22 16:17:15,847 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:234] F-xxxxxxxx-000000000001-00: Setting power to 2000W
2023-10-22 16:17:15,851 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:226] F-xxxxxxxx-000000000001-00: Setting wrapped control switch 1 to on
2023-10-22 16:17:15,865 DEBUG [MQTT Call: F-xxxxxxxx-000000000001-00-LevelSwitch-3] d.a.s.c.LevelSwitch [LevelSwitch.java:226] F-xxxxxxxx-000000000001-00: Setting wrapped control switch 2 to off
2023-10-22 16:17:15,875 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-Switch-6] d.a.s.c.Switch [Switch.java:147] F-xxxxxxxx-000000000001-00: Switching on GPIO 5
2023-10-22 16:17:15,883 INFO [MQTT Call: F-xxxxxxxx-000000000001-00-Switch-7] d.a.s.c.Switch [Switch.java:147] F-xxxxxxxx-000000000001-00: Switching off GPIO 6

Nachfolgend wurde immer status=Off gemeldet.

Der Status wird aus den MQTT-Nachrichten der Schalter (hier GPIO-Schalter) bestimmt. Wenn mindestens ein Schalter eingeschaltet ist, gilt der Stufenschalter auch als eingeschaltet. Leider hast Du als Log-Level DEBUG und nicht TRACE eingestellt, d.h. im Log sind keine MQTT-Nachrichten enthalten. Du kannst gern den Log-Level auf TRACE stellen und ein neues Log-File erzeugen, dann schaue ich mir an, warum der Status manchmal falsch ermittelt wird.

[Florian415]

Hallo Axel,

Danke für die superschnelle Reaktion! Ich spiele die gepatchte Version baldmöglichst ein, beobachte das ein paar Tage (damit wir eine verlässliche Datenlage haben) und melde mich dann mit den Resultaten.

[Lausbua]

@Florian415
Vielen Dank für das Erstellen vom Log mit Trace-Level.

@camueller
Auch ein Danke von mir für deine Geduld und superschnelle Reaktion, habe die Testversion soeben aufgespielt und werde berichten.

[Lausbua]

Nachdem ich die letzten beiden Tage den Stufenschalter mit der Test-Version getestet habe ist der Fehler nicht mehr aufgetreten.

[Florian415]

Hallo Axel & Daniel,

nach etlichen Regentagen heute das erste Mal wieder genügend Sonnenschein auf den Panels, um den Stufenschalter auszufahren. Auch wenn es aktuell nur ein Tagesverlauf ist - dieser sieht gut aus! Auf der Grafik sind v.a. am Morgen die Schaltstufen in der roten Verbrauchskurve schön sichtbar. Die wenigen grünen Akku-Peaks nach unten haben andere Störgrössen als Ursache (z.B. Kochherd, Wärmepumpe, etc) und der Stufenschalter hat die Boilerleistung auch in diesen Fällen jeweils flott runtergefahren.

Eine Anschlussfrage: Beziehen sich die min/max Schaltzeiten nur auf die niedrigste Schaltstufe, oder auch auf jede einzelne der höheren Schaltstufen bzw. das Schalten zwischen diesen? Die Stufen 2 & 3 scheinen mir dynamischer zu reagieren als die erste (Grund-) Stufe.

[camueller]

Das klingt doch sehr gut! Dann werde ich wohl nächste Woche die offizielle Version 2.3.1 releasen.

Die Schaltzeiten beziehen sich auf das Gerät als ganzes und haben keinen Bezug den den einzelnen Schaltstufen.