logo elektroda
logo elektroda
X
logo elektroda
Advanced Search
logo elektroda

OpenBeken Web App unresponsive on ATORCH S1 (BK7231N, CB3S) within 5 minutes

ajay100 72 5
ADVERTISEMENT
Reply | New topic
  • #1 21617981
    ajay100
    Level 5  
    Help with troubleshooting very much appreciated! Recently flashed Tuya ATORCH S1 OpenBeken Web app stops responding within 5 minutes, usually less. This is a smart plug/power metering device.
    Device was working normally with Tuya firmware/API v3.4 and TinyTuya.
    Pinging device continues with about 40% packet loss.
    MQTT Explorer continues to receive to all topics, but device doesn't respond to set commands.
    The device screen continues to update normally.
    Only option is to power cycle device then web app resumes.

    Tried with minimal autoexec.bat
    Code: text Expand Select all Copy to clipboard
    startDriver TuyaMCU


    Config:
    Code: text Expand Select all Copy to clipboard
    {
  "vendor": "ATORCH",
  "bDetailed": "0",
  "name": "Tuya Smart Socket Energy Monitor (CH573F) (BL0942)",
  "model": "S1-B/W/T/H",
  "chip": "BK7231N",
  "board": "CB3S",
  "pins": {},
  "command": "",
  "keywords": [
    "TuyaMCU",
    "LCD"
  ],
  "image": "https://obrazki.elektroda.pl/7012209800_1695398060.jpg",
  "wiki": "https://www.elektroda.com/rtvforum/topic4003739.html"
}


    The logs show nothing abnormal that I can see - sample before unresponsive:
    Code: text Expand Select all Copy to clipboard
    Info:MAIN:Time 344, idle 187753/s, free 72448, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:Publishing val 344 to atorch1/uptime retain=0
Info:MAIN:Time 345, idle 187785/s, free 72448, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:Publishing val 72448 to atorch1/freeheap retain=0
Info:MAIN:Time 346, idle 190146/s, free 72448, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:Publishing val 192.168.25.66 to atorch1/ip retain=0
Info:MAIN:Time 347, idle 188455/s, free 72448, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:Channel has changed! Publishing 0.000000 to channel 0 
Info:MQTT:Publishing val 0.000000 to atorch1/0 retain=0
Info:MAIN:Time 348, idle 185258/s, free 72448, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:Channel has changed! Publishing 0.000000 to channel 1 
Info:MQTT:Publishing val 0.000000 to atorch1/1 retain=0
Info:MAIN:Time 349, idle 185695/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:Channel has changed! Publishing 0.000000 to channel 2 
Info:MQTT:Publishing val 0.000000 to atorch1/2 retain=0
Info:MAIN:Time 350, idle 186813/s, free 72224, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:GEN:dhcp=0 ip=192.168.25.66 gate=192.168.25.1 mask=255.255.255.0 mac=38:a5:c9:09:12:95
Info:GEN:sta: 1, softap: 0, b/g/n
Info:GEN:sta:rssi=-55,ssid=Thing,bssid=86:d8:1b:23:fb:a2,channel=6,cipher_type:CCMP


    Added after 12 [minutes]:

    Additional info
    Occasionally the web app starts responding again after some time without power cycling (several to many minutes later). Here is a sample of logs when that happened just now:
    Code: text Expand Select all Copy to clipboard
    Info:TuyaMCU:Consumed 7 unwanted non-header byte in Tuya MCU buffer
Info:TuyaMCU:Skipped data (part) F1 F1 F1 F1 F1 F1 F1 
Info:MAIN:Time 1682, idle 188436/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1683, idle 189010/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1684, idle 188816/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1685, idle 190282/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1686, idle 189536/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1687, idle 188279/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1688, idle 194110/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:TuyaMCU:Consumed 7 unwanted non-header byte in Tuya MCU buffer
Info:TuyaMCU:Skipped data (part) F1 F1 F1 F1 F1 F1 F1 
Info:MAIN:Time 1689, idle 188453/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1690, idle 188583/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:GEN:dhcp=0 ip=192.168.25.66 gate=192.168.25.1 mask=255.255.255.0 mac=38:a5:c9:09:12:95
Info:GEN:sta: 1, softap: 0, b/g/n
Info:GEN:sta:rssi=-55,ssid=Thing,bssid=86:d8:1b:23:fb:a2,channel=6,cipher_type:CCMP
Info:MAIN:Time 1691, idle 186258/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1692, idle 189582/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:TuyaMCU:Consumed 9 unwanted non-header byte in Tuya MCU buffer
Info:TuyaMCU:Skipped data (part) F1 F1 F1 09 84 24 88 04 F1 
Info:MAIN:Time 1693, idle 187337/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1694, idle 189480/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1695, idle 191359/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:TuyaMCU:Consumed 7 unwanted non-header byte in Tuya MCU buffer
Info:TuyaMCU:Skipped data (part) 01 FE E1 E1 E1 F1 F1 
Info:MAIN:Time 1696, idle 188675/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1697, idle 189520/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1698, idle 189317/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1699, idle 196249/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1700, idle 188279/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:GEN:dhcp=0 ip=192.168.25.66 gate=192.168.25.1 mask=255.255.255.0 mac=38:a5:c9:09:12:95
Info:GEN:sta: 1, softap: 0, b/g/n
Info:GEN:sta:rssi=-56,ssid=Thing,bssid=86:d8:1b:23:fb:a2,channel=6,cipher_type:CCMP
Info:MAIN:Time 1701, idle 185898/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1702, idle 188811/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:TuyaMCU:Consumed 7 unwanted non-header byte in Tuya MCU buffer
Info:TuyaMCU:Skipped data (part) F1 F1 F1 F1 F1 F1 F1 
Info:MAIN:Time 1703, idle 189482/s, free 72456, MQTT 1(2), bWifi 1, secondsWithNoPing -1, socks 2/38 
  • ADVERTISEMENT
  • #2 21618061
    max4elektroda
    Level 20  
    Maybe related, maybe something completely different: I have a similar behavior on my LN882H device.
    Similar, because device seems unavailable for some time. Different: it's not responding at all for some time - but yours seem to be "little" available (ping with losses).
    In my case it seems an issue with lwip, because I won't even get an ARP response and after some time it's back to normal.
    Since it's in use and powered with 230V, I can't simply attach a device for getting serial log...
  • ADVERTISEMENT
  • #3 21618276
    p.kaczmarek2
    Moderator Smart Home  
    Can you try with empty autoexec.bat? Without TuyaMCU driveR?
    Helpful post? Buy me a coffee.
  • ADVERTISEMENT
  • #4 21618315
    ajay100
    Level 5  
    Yes, with an empty autoexec.bat I would say it is about the same as with the single 'startDriver TuyaMCU command'. It is still lagging/unresponsive but if I wait long enough it comes back, maybe taking many minutes. Watching the MQTT stats: Pub number on the home page, it may jump several hundred after a long break.

    Thanks.
  • ADVERTISEMENT
  • #5 21618326
    p.kaczmarek2
    Moderator Smart Home  
    Is PowerSave enabled? Maybe overheating.

    Is the device new? Maybe faulty capacitor or something? I experienced something similar...

    Is MQTT enabled? Try without MQTT.
    Helpful post? Buy me a coffee.
  • #6 21618349
    ajay100
    Level 5  
    With MQTT disabled, it stopped at Time 406 and hasn't come back after 10 minutes.

    The maximum CPU chip temperature I've seen is 50C and I assumed that was because it was working hard or in a loop, etc.

    It could be faulty after the flash procedure, but I was careful (electronics tech.) and it was fine before that.

    Does the large idle figure suggest it's not doing a lot at this stage?
    Code: text Expand Select all Copy to clipboard
    Info:MQTT:mqtt_host empty, not starting mqtt
Info:MAIN:Time 395, idle 190455/s, free 74576, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 396, idle 188943/s, free 74576, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 397, idle 188764/s, free 74576, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 398, idle 189465/s, free 74576, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 399, idle 186308/s, free 62888, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 3/38 
Info:MAIN:Time 400, idle 374123/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:GEN:dhcp=0 ip=192.168.25.66 gate=192.168.25.1 mask=255.255.255.0 mac=38:a5:c9:09:12:95
Info:GEN:sta: 1, softap: 0, b/g/n
Info:GEN:sta:rssi=-57,ssid=Thing,bssid=86:d8:1b:23:fb:a2,channel=6,cipher_type:CCMP
Info:MAIN:Time 401, idle 187031/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 402, idle 185378/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 403, idle 192538/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 404, idle 188208/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 405, idle 377974/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 406, idle 189652/s, free 74584, MQTT 0(25), bWifi 1, secondsWithNoPing -1, socks 2/38 


    Added after 11 [minutes]:

    It has resumed and the next log after Time 406 is Time 1666:
    Code: text Expand Select all Copy to clipboard
    8 
Info:MAIN:Time 1666, idle 188025/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1667, idle 188868/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1668, idle 189025/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1669, idle 187437/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1670, idle 198798/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:GEN:dhcp=0 ip=192.168.25.66 gate=192.168.25.1 mask=255.255.255.0 mac=38:a5:c9:09:12:95
Info:GEN:sta: 1, softap: 0, b/g/n
Info:GEN:sta:rssi=-57,ssid=Thing,bssid=86:d8:1b:23:fb:a2,channel=6,cipher_type:CCMP
Info:MAIN:Time 1671, idle 185758/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1672, idle 188983/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1673, idle 189567/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MAIN:Time 1674, idle 189142/s, free 74584, MQTT 0(104), bWifi 1, secondsWithNoPing -1, socks 2/38 
Info:MQTT:mqtt_host empty, not starting mqtt
Reply | New topic
Report a violation of the law
Popular Topics
ADVERTISEMENT