KaufHA / PLF10

Files for the PLF10 Power Monitoring Smart Plug.
26 stars 16 forks source link

Problem with Kauf Plug and TasmoAdmin, plug crashing and rebooting #5

Closed deepcoder closed 1 year ago

deepcoder commented 2 years ago

I have TasoAdmin v1.8.0 running in a docker container on a Ubuntu 20 x86_64 machine. When I leave the app open to the devices page, about once every 20 to 30 minutes the Kauf Plug I am testing crashes. If I close the TasoAdmin page, the problem stops. I'm not seeing this issue on any other of my tasmota devices, including a number of plug devices.

I'm not sure how to capture the before events better, but this is what I have if I leave the console open for the plug. Let me know how I can capture better data.

10.1.0(tasmota) on Plug.

00:00:00.001 HDW: ESP8266EX
00:00:00.050 CFG: Loaded from flash at FB, Count 369
00:00:00.056 QPC: Count 1
00:00:00.065 Project tasmota - Tasmota Version 10.1.0(tasmota)-2_7_4_9(2021-12-08T14:47:33)
00:00:00.555 WIF: Connecting to AP1 gfi Channel 3 BSSId 48:8F:5A:AA:BB:FF in mode 11n as tasmota-EBC7B8-1976...
00:00:01.753 WIF: Connected
00:00:02.007 HTP: Web server active on tasmota-EBC7B8-1976 with IP address 192.168.2.172
19:22:40.040 MQT: Attempting connection...
19:22:40.056 MQT: Connected
19:22:40.059 MQT: tele/tasmota_EBC7B8/LWT = Online (retained)
19:22:40.062 MQT: cmnd/tasmota_EBC7B8/POWER = 
19:22:40.075 MQT: tele/tasmota_EBC7B8/INFO1 = {"Info1":{"Module":"KAUF Plug","Version":"10.1.0(tasmota)","FallbackTopic":"cmnd/DVES_EBC7B8_fb/","GroupTopic":"cmnd/tasmotas/"}}
19:22:40.084 MQT: tele/tasmota_EBC7B8/INFO2 = {"Info2":{"WebServerMode":"Admin","Hostname":"tasmota-EBC7B8-1976","IPAddress":"192.168.2.172"}}
19:22:40.105 MQT: tele/tasmota_EBC7B8/INFO3 = {"Info3":{"RestartReason":{"Exception":3,"Reason":"Exception","EPC":["4027264e","00000000","00000000"],"EXCVADDR":"40272676","DEPC":"00000000","CallChain":["40105c7c","40105c79","400005e1","40255ea1","40266c47","40000f68","40000f58","401011da","40100a50","40100a71","402738a0","402738ad","402738f2","4024b418","40000f49","40000f49","40000f49","40000e19","40105a7d","40105a83","4010000d","4026c334","4026c2e5","401058c5","401054aa","40104df9","401053ad","40105685","4010394e","4000050c","40100a50"]}}}
19:22:40.147 MQT: stat/tasmota_EBC7B8/RESULT = {"POWER":"ON"}
19:22:40.152 MQT: stat/tasmota_EBC7B8/POWER = ON
19:22:43.485 QPC: Reset
19:22:45.111 MQT: stat/tasmota_EBC7B8/STATUS = {"Status":{"Module":0,"DeviceName":"Tasmota","FriendlyName":["Tasmota"],"Topic":"tasmota_EBC7B8","ButtonTopic":"0","Power":1,"PowerOnState":0,"LedState":1,"LedMask":"FFFF","SaveData":1,"SaveState":1,"SwitchTopic":"0","SwitchMode":[0,0,0,0,0,0,0,0],"ButtonRetain":0,"SwitchRetain":0,"SensorRetain":0,"PowerRetain":0,"InfoRetain":0,"StateRetain":0}}
19:22:45.142 MQT: stat/tasmota_EBC7B8/STATUS1 = {"StatusPRM":{"Baudrate":115200,"SerialConfig":"8N1","GroupTopic":"tasmotas","OtaUrl":"http://ota.tasmota.com/tasmota/release/tasmota.bin.gz","RestartReason":"Exception","Uptime":"0T00:00:10","StartupUTC":"2022-03-08T18:22:35","Sleep":50,"CfgHolder":4617,"BootCount":224,"BCResetTime":"2021-05-03T05:06:29","SaveCount":369,"SaveAddress":"FB000"}}
19:22:45.175 MQT: stat/tasmota_EBC7B8/STATUS2 = {"StatusFWR":{"Version":"10.1.0(tasmota)","BuildDateTime":"2021-12-08T14:47:33","Boot":31,"Core":"2_7_4_9","SDK":"2.2.2-dev(38a443e)","CpuFrequency":80,"Hardware":"ESP8266EX","CR":"344/699"}}
19:22:45.196 MQT: stat/tasmota_EBC7B8/STATUS3 = {"StatusLOG":{"SerialLog":2,"WebLog":2,"MqttLog":0,"SysLog":0,"LogHost":"","LogPort":514,"SSId":["gfi",""],"TelePeriod":10,"Resolution":"558180C0","SetOption":["00208009","2805C80001000600003C5A0A000000000000","00000080","00006000","00004000"]}}
19:22:45.230 MQT: stat/tasmota_EBC7B8/STATUS4 = {"StatusMEM":{"ProgramSize":616,"Free":384,"Heap":26,"ProgramFlashSize":1024,"FlashSize":1024,"FlashChipId":"14605E","FlashFrequency":40,"FlashMode":3,"Features":["00000809","8FDAC787","04368001","000000CF","010013C0","C000F981","00004004","00001000","00000020"],"Drivers":"1,2,3,4,5,6,7,8,9,10,12,16,18,19,20,21,22,24,26,27,29,30,35,37,45","Sensors":"1,2,3,4,5,6"}}
19:22:45.264 MQT: stat/tasmota_EBC7B8/STATUS5 = {"StatusNET":{"Hostname":"tasmota-EBC7B8-1976","IPAddress":"192.168.2.172","Gateway":"192.168.2.2","Subnetmask":"255.255.255.0","DNSServer1":"192.168.2.242","DNSServer2":"1.1.1.1","Mac":"3C:61:05:EE:AA:CC","Webserver":2,"HTTP_API":1,"WifiConfig":2,"WifiPower":17.0}}
19:22:45.291 MQT: stat/tasmota_EBC7B8/STATUS6 = {"StatusMQT":{"MqttHost":"192.168.2.242","MqttPort":1883,"MqttClientMask":"DVES_%06X","MqttClient":"DVES_EBC7B8","MqttUser":"DVES_USER","MqttCount":1,"MAX_PACKET_SIZE":1200,"KEEPALIVE":30,"SOCKET_TIMEOUT":4}}
19:22:45.315 MQT: stat/tasmota_EBC7B8/STATUS7 = {"StatusTIM":{"UTC":"2022-03-08T18:22:45","Local":"2022-03-08T19:22:45","StartDST":"2022-03-27T02:00:00","EndDST":"2022-10-30T03:00:00","Timezone":"+01:00","Sunrise":"07:17","Sunset":"18:43"}}
19:22:45.332 MQT: stat/tasmota_EBC7B8/STATUS9 = {"StatusPTH":{"PowerDelta":[0,0,0],"PowerLow":0,"PowerHigh":0,"VoltageLow":0,"VoltageHigh":0,"CurrentLow":0,"CurrentHigh":0}}
19:22:45.352 MQT: stat/tasmota_EBC7B8/STATUS10 = {"StatusSNS":{"Time":"2022-03-08T19:22:45","ENERGY":{"TotalStartTime":"2021-05-03T05:06:29","Total":189.245,"Yesterday":0.111,"Today":0.100,"Period": 0,"Power": 5,"ApparentPower":11,"ReactivePower": 9,"Factor":0.50,"Voltage":125,"Current":0.086}}}
19:22:45.375 MQT: stat/tasmota_EBC7B8/STATUS11 = {"StatusSTS":{"Time":"2022-03-08T19:22:45","Uptime":"0T00:00:10","UptimeSec":10,"Heap":24,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":1,"POWER":"ON","Wifi":{"AP":1,"SSId":"gfi","BSSId":"48:8F:5A:AA:BB:FF","Channel":3,"Mode":"11n","RSSI":88,"Signal":-56,"LinkCount":1,"Downtime":"0T00:00:03"}}}
19:22:45.414 MQT: stat/tasmota_EBC7B8/STATUS12 = {"StatusSTK":{"Exception":3,"Reason":"Exception","EPC":["4027264e","00000000","00000000"],"EXCVADDR":"40272676","DEPC":"00000000","CallChain":["40105c7c","40105c79","400005e1","40255ea1","40266c47","40000f68","40000f58","401011da","40100a50","40100a71","402738a0","402738ad","402738f2","4024b418","40000f49","40000f49","40000f49","40000e19","40105a7d","40105a83","4010000d","4026c334","4026c2e5","401058c5","401054aa","40104df9","401053ad","40105685","4010394e","4000050c","40100a50"]}}
19:22:53.572 MQT: stat/tasmota_EBC7B8/STATUS = {"Status":{"Module":0,"DeviceName":"Tasmota","FriendlyName":["Tasmota"],"Topic":"tasmota_EBC7B8","ButtonTopic":"0","Power":1,"PowerOnState":0,"LedState":1,"LedMask":"FFFF","SaveData":1,"SaveState":1,"SwitchTopic":"0","SwitchMode":[0,0,0,0,0,0,0,0],"ButtonRetain":0,"SwitchRetain":0,"SensorRetain":0,"PowerRetain":0,"InfoRetain":0,"StateRetain":0}}
19:22:53.604 MQT: stat/tasmota_EBC7B8/STATUS1 = {"StatusPRM":{"Baudrate":115200,"SerialConfig":"8N1","GroupTopic":"tasmotas","OtaUrl":"http://ota.tasmota.com/tasmota/release/tasmota.bin.gz","RestartReason":"Exception","Uptime":"0T00:00:18","StartupUTC":"2022-03-08T18:22:35","Sleep":50,"CfgHolder":4617,"BootCount":225,"BCResetTime":"2021-05-03T05:06:29","SaveCount":370,"SaveAddress":"FA000"}}
19:22:53.638 MQT: stat/tasmota_EBC7B8/STATUS2 = {"StatusFWR":{"Version":"10.1.0(tasmota)","BuildDateTime":"2021-12-08T14:47:33","Boot":31,"Core":"2_7_4_9","SDK":"2.2.2-dev(38a443e)","CpuFrequency":80,"Hardware":"ESP8266EX","CR":"344/699"}}
19:22:53.658 MQT: stat/tasmota_EBC7B8/STATUS3 = {"StatusLOG":{"SerialLog":2,"WebLog":2,"MqttLog":0,"SysLog":0,"LogHost":"","LogPort":514,"SSId":["gfi",""],"TelePeriod":10,"Resolution":"558180C0","SetOption":["00208009","2805C80001000600003C5A0A000000000000","00000080","00006000","00004000"]}}
19:22:53.690 MQT: stat/tasmota_EBC7B8/STATUS4 = {"StatusMEM":{"ProgramSize":616,"Free":384,"Heap":25,"ProgramFlashSize":1024,"FlashSize":1024,"FlashChipId":"14605E","FlashFrequency":40,"FlashMode":3,"Features":["00000809","8FDAC787","04368001","000000CF","010013C0","C000F981","00004004","00001000","00000020"],"Drivers":"1,2,3,4,5,6,7,8,9,10,12,16,18,19,20,21,22,24,26,27,29,30,35,37,45","Sensors":"1,2,3,4,5,6"}}
19:22:53.724 MQT: stat/tasmota_EBC7B8/STATUS5 = {"StatusNET":{"Hostname":"tasmota-EBC7B8-1976","IPAddress":"192.168.2.172","Gateway":"192.168.2.2","Subnetmask":"255.255.255.0","DNSServer1":"192.168.2.242","DNSServer2":"1.1.1.1","Mac":"3C:61:05:EE:AA:CC","Webserver":2,"HTTP_API":1,"WifiConfig":2,"WifiPower":17.0}}
19:22:53.749 MQT: stat/tasmota_EBC7B8/STATUS6 = {"StatusMQT":{"MqttHost":"192.168.2.242","MqttPort":1883,"MqttClientMask":"DVES_%06X","MqttClient":"DVES_EBC7B8","MqttUser":"DVES_USER","MqttCount":1,"MAX_PACKET_SIZE":1200,"KEEPALIVE":30,"SOCKET_TIMEOUT":4}}
19:22:53.773 MQT: stat/tasmota_EBC7B8/STATUS7 = {"StatusTIM":{"UTC":"2022-03-08T18:22:53","Local":"2022-03-08T19:22:53","StartDST":"2022-03-27T02:00:00","EndDST":"2022-10-30T03:00:00","Timezone":"+01:00","Sunrise":"07:17","Sunset":"18:43"}}
19:22:53.792 MQT: stat/tasmota_EBC7B8/STATUS9 = {"StatusPTH":{"PowerDelta":[0,0,0],"PowerLow":0,"PowerHigh":0,"VoltageLow":0,"VoltageHigh":0,"CurrentLow":0,"CurrentHigh":0}}
19:22:53.812 MQT: stat/tasmota_EBC7B8/STATUS10 = {"StatusSNS":{"Time":"2022-03-08T19:22:53","ENERGY":{"TotalStartTime":"2021-05-03T05:06:29","Total":189.245,"Yesterday":0.111,"Today":0.100,"Power": 5,"ApparentPower":11,"ReactivePower": 9,"Factor":0.49,"Voltage":125,"Current":0.086}}}
19:22:53.837 MQT: stat/tasmota_EBC7B8/STATUS11 = {"StatusSTS":{"Time":"2022-03-08T19:22:53","Uptime":"0T00:00:18","UptimeSec":18,"Heap":25,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":1,"POWER":"ON","Wifi":{"AP":1,"SSId":"gfi","BSSId":"48:8F:5A:AA:BB:FF","Channel":3,"Mode":"11n","RSSI":84,"Signal":-58,"LinkCount":1,"Downtime":"0T00:00:03"}}}
19:22:53.873 MQT: stat/tasmota_EBC7B8/STATUS12 = {"StatusSTK":{"Exception":3,"Reason":"Exception","EPC":["4027264e","00000000","00000000"],"EXCVADDR":"40272676","DEPC":"00000000","CallChain":["40105c7c","40105c79","400005e1","40255ea1","40266c47","40000f68","40000f58","401011da","40100a50","40100a71","402738a0","402738ad","402738f2","4024b418","40000f49","40000f49","40000f49","40000e19","40105a7d","40105a83","4010000d","4026c334","4026c2e5","401058c5","401054aa","40104df9","401053ad","40105685","4010394e","4000050c","40100a50"]}}
19:22:54.413 MQT: tele/tasmota_EBC7B8/STATE = {"Time":"2022-03-08T19:22:54","Uptime":"0T00:00:19","UptimeSec":19,"Heap":26,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":43,"MqttCount":1,"POWER":"ON","Wifi":{"AP":1,"SSId":"gfi","BSSId":"48:8F:5A:AA:BB:FF","Channel":3,"Mode":"11n","RSSI":84,"Signal":-58,"LinkCount":1,"Downtime":"0T00:00:03"}}
19:22:54.446 MQT: tele/tasmota_EBC7B8/SENSOR = {"Time":"2022-03-08T19:22:54","ENERGY":{"TotalStartTime":"2021-05-03T05:06:29","Total":189.245,"Yesterday":0.111,"Today":0.100,"Period": 0,"Power": 5,"ApparentPower":11,"ReactivePower": 9,"Factor":0.50,"Voltage":125,"Current":0.086}}
19:23:00.891 MQT: stat/tasmota_EBC7B8/STATUS = {"Status":{"Module":0,"DeviceName":"Tasmota","FriendlyName":["Tasmota"],"Topic":"tasmota_EBC7B8","ButtonTopic":"0","Power":1,"PowerOnState":0,"LedState":1,"LedMask":"FFFF","SaveData":1,"SaveState":1,"SwitchTopic":"0","SwitchMode":[0,0,0,0,0,0,0,0],"ButtonRetain":0,"SwitchRetain":0,"SensorRetain":0,"PowerRetain":0,"InfoRetain":0,"StateRetain":0}}
19:23:00.922 MQT: stat/tasmota_EBC7B8/STATUS1 = {"StatusPRM":{"Baudrate":115200,"SerialConfig":"8N1","GroupTopic":"tasmotas","OtaUrl":"http://ota.tasmota.com/tasmota/release/tasmota.bin.gz","RestartReason":"Exception","Uptime":"0T00:00:25","StartupUTC":"2022-03-08T18:22:35","Sleep":50,"CfgHolder":4617,"BootCount":225,"BCResetTime":"2021-05-03T05:06:29","SaveCount":370,"SaveAddress":"FA000"}}
19:23:00.955 MQT: stat/tasmota_EBC7B8/STATUS2 = {"StatusFWR":{"Version":"10.1.0(tasmota)","BuildDateTime":"2021-12-08T14:47:33","Boot":31,"Core":"2_7_4_9","SDK":"2.2.2-dev(38a443e)","CpuFrequency":80,"Hardware":"ESP8266EX","CR":"344/699"}}
19:23:00.977 MQT: stat/tasmota_EBC7B8/STATUS3 = {"StatusLOG":{"SerialLog":2,"WebLog":2,"MqttLog":0,"SysLog":0,"LogHost":"","LogPort":514,"SSId":["gfi",""],"TelePeriod":10,"Resolution":"558180C0","SetOption":["00208009","2805C80001000600003C5A0A000000000000","00000080","00006000","00004000"]}}
19:23:01.003 MQT: stat/tasmota_EBC7B8/STATUS4 = {"StatusMEM":{"ProgramSize":616,"Free":384,"Heap":25,"ProgramFlashSize":1024,"FlashSize":1024,"FlashChipId":"14605E","FlashFrequency":40,"FlashMode":3,"Features":["00000809","8FDAC787","04368001","000000CF","010013C0","C000F981","00004004","00001000","00000020"],"Drivers":"1,2,3,4,5,6,7,8,9,10,12,16,18,19,20,21,22,24,26,27,29,30,35,37,45","Sensors":"1,2,3,4,5,6"}}
19:23:01.036 MQT: stat/tasmota_EBC7B8/STATUS5 = {"StatusNET":{"Hostname":"tasmota-EBC7B8-1976","IPAddress":"192.168.2.172","Gateway":"192.168.2.2","Subnetmask":"255.255.255.0","DNSServer1":"192.168.2.242","DNSServer2":"1.1.1.1","Mac":"3C:61:05:EE:AA:CC","Webserver":2,"HTTP_API":1,"WifiConfig":2,"WifiPower":17.0}}
19:23:01.062 MQT: stat/tasmota_EBC7B8/STATUS6 = {"StatusMQT":{"MqttHost":"192.168.2.242","MqttPort":1883,"MqttClientMask":"DVES_%06X","MqttClient":"DVES_EBC7B8","MqttUser":"DVES_USER","MqttCount":1,"MAX_PACKET_SIZE":1200,"KEEPALIVE":30,"SOCKET_TIMEOUT":4}}
19:23:01.087 MQT: stat/tasmota_EBC7B8/STATUS7 = {"StatusTIM":{"UTC":"2022-03-08T18:23:01","Local":"2022-03-08T19:23:01","StartDST":"2022-03-27T02:00:00","EndDST":"2022-10-30T03:00:00","Timezone":"+01:00","Sunrise":"07:17","Sunset":"18:43"}}
19:23:01.105 MQT: stat/tasmota_EBC7B8/STATUS9 = {"StatusPTH":{"PowerDelta":[0,0,0],"PowerLow":0,"PowerHigh":0,"VoltageLow":0,"VoltageHigh":0,"CurrentLow":0,"CurrentHigh":0}}
19:23:01.125 MQT: stat/tasmota_EBC7B8/STATUS10 = {"StatusSNS":{"Time":"2022-03-08T19:23:01","ENERGY":{"TotalStartTime":"2021-05-03T05:06:29","Total":189.245,"Yesterday":0.111,"Today":0.100,"Power": 5,"ApparentPower":11,"ReactivePower": 9,"Factor":0.48,"Voltage":125,"Current":0.086}}}
19:23:01.148 MQT: stat/tasmota_EBC7B8/STATUS11 = {"StatusSTS":{"Time":"2022-03-08T19:23:01","Uptime":"0T00:00:26","UptimeSec":26,"Heap":25,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":1,"POWER":"ON","Wifi":{"AP":1,"SSId":"gfi","BSSId":"48:8F:5A:AA:BB:FF","Channel":3,"Mode":"11n","RSSI":90,"Signal":-55,"LinkCount":1,"Downtime":"0T00:00:03"}}}
19:23:01.185 MQT: stat/tasmota_EBC7B8/STATUS12 = {"StatusSTK":{"Exception":3,"Reason":"Exception","EPC":["4027264e","00000000","00000000"],"EXCVADDR":"40272676","DEPC":"00000000","CallChain":["40105c7c","40105c79","400005e1","40255ea1","40266c47","40000f68","40000f58","401011da","40100a50","40100a71","402738a0","402738ad","402738f2","4024b418","40000f49","40000f49","40000f49","40000e19","40105a7d","40105a83","4010000d","4026c334","4026c2e5","401058c5","401054aa","40104df9","401053ad","40105685","4010394e","4000050c","40100a50"]}}
19:23:04.427 MQT: tele/tasmota_EBC7B8/STATE = {"Time":"2022-03-08T19:23:04","Uptime":"0T00:00:29","UptimeSec":29,"Heap":26,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":1,"POWER":"ON","Wifi":{"AP":1,"SSId":"gfi","BSSId":"48:8F:5A:AA:BB:FF","Channel":3,"Mode":"11n","RSSI":92,"Signal":-54,"LinkCount":1,"Downtime":"0T00:00:03"}}
19:23:04.458 MQT: tele/tasmota_EBC7B8/SENSOR = {"Time":"2022-03-08T19:23:04","ENERGY":{"TotalStartTime":"2021-05-03T05:06:29","Total":189.245,"Yesterday":0.111,"Today":0.100,"Period": 0,"Power": 5,"ApparentPower":11,"ReactivePower": 9,"Factor":0.50,"Voltage":125,"Current":0.086}}
KaufHA commented 2 years ago

Might try to upgrade Tasmota to 11.0 and see if that helps. Also maybe try doing a reset command in case there's some weird settings issue. Make sure WifiPower is 17 or less. Maybe turn down WifiPower to like 14 to see if that makes a difference. I'll let you know if I think of anything else to try.

I don't think you're going to get much better logging even if you soldered wires to the TX output to get logging that way. These show a watchdog timer reset and the call chain. Someone who has experience debugging Tasmota could probably help figure out what code is running at those addresses. Might give you a clue about what's going wrong.

19:22:40.105 MQT: tele/tasmota_EBC7B8/INFO3 = {"Info3":{"RestartReason":{"Exception":3,"Reason":"Exception","EPC":["4027264e","00000000","00000000"],"EXCVADDR":"40272676","DEPC":"00000000","CallChain":["40105c7c","40105c79","400005e1","40255ea1","40266c47","40000f68","40000f58","401011da","40100a50","40100a71","402738a0","402738ad","402738f2","4024b418","40000f49","40000f49","40000f49","40000e19","40105a7d","40105a83","4010000d","4026c334","4026c2e5","401058c5","401054aa","40104df9","401053ad","40105685","4010394e","4000050c","40100a50"]}}}