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.
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:
define wbOn notify Wohnzimmer.Brunnen:POWER:.ON { stacktrace() }
Nach dem Power:OFF um xx:20:00 kommen nach 7 Sekunden (manchmal) noch 2 Events:
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)
Diese Nachrichten kommen vom MQTT Geraet direkt.
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:
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).