[gelöst] Sonoff-Schalter schaltet gelegentlich nach ON-FOR-TIMER wieder ein

Begonnen von roedert, 20 Juni 2019, 22:25:42

Vorheriges Thema - Nächstes Thema
Drucken
Nach unten Seiten1
Benutzer-Aktionen

roedert

20 Juni 2019, 22:25:42 Letzte Bearbeitung: 21 Juni 2019, 16:34:29 von roedert
Ich habe ein Sonoff/Tasmota geflashte GOSUND SP111 per MQTT2-Device angebunden, was auch problemlos funktioniert.
Zu jeder vollen Stunde schalte ich diese für 20 Minuten mit set on-for-timer 1200 an, was prinzipiell auch funktioniert.
Allerdings habe ich gemerkt, das das Teil auch nach den 20 Minuten manchmal noch an ist, daraufhin habe ich diese mal mitgeloggt:
+---------------------+--------------------+--------------+------------+---------+-------+------+
| TIMESTAMP           | DEVICE             | TYPE         | EVENT      | READING | VALUE | UNIT |
+---------------------+--------------------+--------------+------------+---------+-------+------+

| 2019-06-20 15:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 15:20:01 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 16:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 16:20:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 16:20:07 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 17:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 17:20:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 18:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 18:20:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 18:20:07 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 19:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 19:20:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 20:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 20:20:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 21:00:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
| 2019-06-20 21:20:00 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: OFF | POWER   | OFF   |      |
| 2019-06-20 21:20:10 | Wohnzimmer.Brunnen | MQTT2_DEVICE | POWER: ON  | POWER   | ON    |      |
+---------------------+--------------------+--------------+------------+---------+-------+------+

Was auffällt ist dass manchmal einige Sekunden nach dem Abschalten das Teil wieder angeschaltet wird .... hat einer Idee woher das kommen könnte?
Ich vermute einen Fehler in der ON-FOR-TIMER-Implementierung im MQTT2-DEVICE-Modul, vorher mit einem Homematic-Schalter hatte ich keine Probleme und habe an der sonstigen Logik auch nichts geändert.

rudolfkoenig

#1
21 Juni 2019, 08:33:58
ZitatIch vermute einen Fehler in der ON-FOR-TIMER-Implementierung im MQTT2-DEVICE-Modul,
Das MQTT2-DEViCE Modul selbst implementiert kein on-for-timer, es wird vom SetExtensions genommen, was auch viele andere Module (ZWave, etc) nutzen.
Ich schlage vor, die Aufrufe mit einem notify zu protokollieren:
Code Auswählen
define wbOn notify Wohnzimmer.Brunnen:POWER:.ON { stacktrace() }

roedert

#2
21 Juni 2019, 10:37:19
Nach dem Power:OFF um xx:20:00 kommen nach 7 Sekunden (manchmal) noch 2 Events:

Code Auswählen
2019.06.21 10:20:00.162 2: wbOn: Wohnzimmer.Brunnen POWER: OFF
2019.06.21 10:20:00.162 1: stacktrace:
2019.06.21 10:20:00.162 1:     (eval)                              called by fhem.pl (1131)
2019.06.21 10:20:00.162 1:     main::AnalyzePerlCommand            called by fhem.pl (1156)
2019.06.21 10:20:00.162 1:     main::AnalyzeCommand                called by fhem.pl (1085)
2019.06.21 10:20:00.162 1:     main::AnalyzeCommandChain           called by /opt/fhem/FHEM/91_notify.pm (121)
2019.06.21 10:20:00.162 1:     main::notify_Exec                   called by fhem.pl (3750)
2019.06.21 10:20:00.162 1:     main::CallFn                        called by fhem.pl (3670)
2019.06.21 10:20:00.162 1:     main::DoTrigger                     called by fhem.pl (4036)
2019.06.21 10:20:00.162 1:     main::Dispatch                      called by /opt/fhem/FHEM/00_MQTT2_SERVER.pm (433)
2019.06.21 10:20:00.162 1:     main::MQTT2_SERVER_doPublish        called by /opt/fhem/FHEM/00_MQTT2_SERVER.pm (327)
2019.06.21 10:20:00.162 1:     main::MQTT2_SERVER_Read             called by fhem.pl (3750)
2019.06.21 10:20:00.162 1:     main::CallFn                        called by fhem.pl (748)
2019.06.21 10:20:02.062 2: NOTIFY LCDdisplay.A_nfy: Aussen.Temperatur humidity: 74
2019.06.21 10:20:07.752 2: wbOn: Wohnzimmer.Brunnen POWER:
2019.06.21 10:20:07.753 1: stacktrace:
2019.06.21 10:20:07.753 1:     (eval)                              called by fhem.pl (1131)
2019.06.21 10:20:07.753 1:     main::AnalyzePerlCommand            called by fhem.pl (1156)
2019.06.21 10:20:07.753 1:     main::AnalyzeCommand                called by fhem.pl (1085)
2019.06.21 10:20:07.753 1:     main::AnalyzeCommandChain           called by /opt/fhem/FHEM/91_notify.pm (121)
2019.06.21 10:20:07.753 1:     main::notify_Exec                   called by fhem.pl (3750)
2019.06.21 10:20:07.753 1:     main::CallFn                        called by fhem.pl (3670)
2019.06.21 10:20:07.753 1:     main::DoTrigger                     called by fhem.pl (4036)
2019.06.21 10:20:07.753 1:     main::Dispatch                      called by /opt/fhem/FHEM/00_MQTT2_SERVER.pm (433)
2019.06.21 10:20:07.753 1:     main::MQTT2_SERVER_doPublish        called by /opt/fhem/FHEM/00_MQTT2_SERVER.pm (327)
2019.06.21 10:20:07.753 1:     main::MQTT2_SERVER_Read             called by fhem.pl (3750)
2019.06.21 10:20:07.753 1:     main::CallFn                        called by fhem.pl (748)
2019.06.21 10:20:07.847 2: wbOn: Wohnzimmer.Brunnen POWER: ON
2019.06.21 10:20:07.847 1: stacktrace:
2019.06.21 10:20:07.847 1:     (eval)                              called by fhem.pl (1131)
2019.06.21 10:20:07.847 1:     main::AnalyzePerlCommand            called by fhem.pl (1156)
2019.06.21 10:20:07.847 1:     main::AnalyzeCommand                called by fhem.pl (1085)
2019.06.21 10:20:07.847 1:     main::AnalyzeCommandChain           called by /opt/fhem/FHEM/91_notify.pm (121)
2019.06.21 10:20:07.847 1:     main::notify_Exec                   called by fhem.pl (3750)
2019.06.21 10:20:07.847 1:     main::CallFn                        called by fhem.pl (3670)
2019.06.21 10:20:07.847 1:     main::DoTrigger                     called by fhem.pl (4036)
2019.06.21 10:20:07.848 1:     main::Dispatch                      called by /opt/fhem/FHEM/00_MQTT2_SERVER.pm (433)
2019.06.21 10:20:07.848 1:     main::MQTT2_SERVER_doPublish        called by /opt/fhem/FHEM/00_MQTT2_SERVER.pm (327)
2019.06.21 10:20:07.848 1:     main::MQTT2_SERVER_Read             called by fhem.pl (3750)
2019.06.21 10:20:07.848 1:     main::CallFn                        called by fhem.pl (748)

rudolfkoenig

#3
21 Juni 2019, 10:45:30
Diese Nachrichten kommen vom MQTT Geraet direkt.

roedert

#4
21 Juni 2019, 15:37:43 Letzte Bearbeitung: 21 Juni 2019, 16:33:46 von roedert
Stimmt, das Problem liegt in der Tasmota-FW/Gosund SP111 selbst.
Es ist jetzt sich vorgekommen, dass nach einem normalen Ausschalten nach einigen Sekunden wieder eingeschaltet wird ... das Log im Gerät zeigt, dass es zusammen mit dem Ausschaltbefehl ab und an einen Neustart macht:

Code Auswählen
00:00:00 Project sonoff Sonoff Version 6.5.0(release-sonoff)-2_3_0
00:00:00 WIF: Connecting to AP1 TRnet in mode 11N as Sonoff-08...
00:00:03 RSL: tele/sonoff_08/SENSOR = {"Time":"1970-01-01T00:00:03","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Power":6,"ApparentPower":36,"ReactivePower":35,"Factor":0.16,"Voltage":229,"Current":0.156}}
00:00:04 WIF: Connected
00:00:04 HTP: Web server active on Sonoff-08 with IP address 172.16.150.208
00:00:05 MQT: Attempting connection...
00:00:05 MQT: Connected
00:00:05 MQT: tele/sonoff_08/LWT = Online (retained)
00:00:05 MQT: cmnd/sonoff_08/POWER =
00:00:05 MQT: tele/sonoff_08/INFO1 = {"Module":"Gosund SP111","Version":"6.5.0(release-sonoff)","FallbackTopic":"cmnd/Sonoff_08_fb/","GroupTopic":"sonoffs"}
00:00:05 MQT: tele/sonoff_08/INFO2 = {"WebServerMode":"Admin","Hostname":"Sonoff-08","IPAddress":"172.16.150.208"}
00:00:05 MQT: tele/sonoff_08/INFO3 = {"RestartReason":"External System"}
00:00:05 MQT: stat/sonoff_08/RESULT = {"POWER":"ON"}
00:00:05 MQT: stat/sonoff_08/POWER = ON
00:00:06 MQT: tele/sonoff_08/SENSOR = {"Time":"1970-01-01T00:00:06","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Power":3,"ApparentPower":35,"ReactivePower":35,"Factor":0.09,"Voltage":229,"Current":0.153}}
00:00:08 MQT: tele/sonoff_08/SENSOR = {"Time":"1970-01-01T00:00:08","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Power":6,"ApparentPower":31,"ReactivePower":31,"Factor":0.19,"Voltage":229,"Current":0.137}}
14:34:46 MQT: tele/sonoff_08/STATE = {"Time":"2019-06-21T14:34:46","Uptime":"0T00:00:14","Vcc":3.170,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"POWER":"ON","Wifi":{"AP":1,"SSId":"TRnet","BSSId":"82:2A:A8:C4:DB:88","Channel":6,"RSSI":60,"LinkCount":1,"Downtime":"0T00:00:04"}}
14:34:46 MQT: tele/sonoff_08/SENSOR = {"Time":"2019-06-21T14:34:46","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Period":0,"Power":4,"ApparentPower":36,"ReactivePower":36,"Factor":0.11,"Voltage":229,"Current":0.157}}
14:34:48 MQT: tele/sonoff_08/SENSOR = {"Time":"2019-06-21T14:34:48","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Power":6,"ApparentPower":33,"ReactivePower":33,"Factor":0.19,"Voltage":229,"Current":0.145}}
14:34:49 MQT: tele/sonoff_08/SENSOR = {"Time":"2019-06-21T14:34:49","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Power":3,"ApparentPower":33,"ReactivePower":33,"Factor":0.10,"Voltage":229,"Current":0.145}}
14:34:52 MQT: tele/sonoff_08/SENSOR = {"Time":"2019-06-21T14:34:52","ENERGY":{"TotalStartTime":"2019-06-18T17:07:44","Total":0.000,"Yesterday":0.000,"Today":0.000,"Power":6,"ApparentPower":32,"ReactivePower":32,"Factor":0.18,"Voltage":229,"Current":0.141}}

PS: Es scheint an der angeschlossenen Brunnenpumpe zu liegen, ohne Last kommen die Abstürze nicht. Es ist eine kleine Zimmerbrunnenpumpe, direkt mit 230V (kein Steckernetzteil).
Drucken
Nach oben Seiten1
Benutzer-Aktionen