search

arendst / Tasmota

Alternative firmware for ESP8266 and ESP32 based devices with easy configuration using webUI, OTA updates, automation using timers or rules, expandability and entirely local control over MQTT, HTTP, Serial or KNX. Full documentation at
https://tasmota.github.io/docs
GNU General Public License v3.0
22.16k stars 4.8k forks source link

Troubleshooting continuation from #14032 #14043

Closed Hans-Sh closed 2 years ago

Hans-Sh commented 2 years ago

PROBLEM DESCRIPTION

Approx. 14 hours after reflashing Sonoff Basic R2 with 10.1.0.1 (fix for #14032), which solved Wifi issues and connected fast and easy to Asus network in N mode, I was unable to connect to this device via Web. Serial log showed it had problems to connect to ASUS (2,4 and 5 Ghz SSID's separated) in N mode. It could connect after Wifi 3 command but it showed Execption 9 and 0. See the serial log.

REQUESTED INFORMATION

Make sure your have performed every step and checked the applicable boxes before submitting your issue. Thank you!

- [ ] If using rules, provide the output of this command: `Backlog Rule1; Rule2; Rule3`:
```lua
  Rules output here:
none

00:00:00.001 HDW: ESP8266EX 00:00:00.050 CFG: Loaded from flash at FA, Count 58 00:00:00.055 QPC: Count 1 00:00:00.064 Project tasmota - Tasmota Version 10.1.0.1(tasmota)-2_7_4_9(2021-12-12T20:09:35) 00:00:04.503 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:00:06.525 QPC: Reset 00:00:13.800 WIF: Connect failed with AP timeout 00:00:26.768 WIF: Connect failed with AP timeout 00:00:32.124 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:00:41.760 WIF: Connect failed with AP timeout 00:00:54.781 WIF: Connect failed with AP timeout 00:01:00.131 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:01:09.770 WIF: Connect failed with AP timeout 00:01:22.789 WIF: Connect failed with AP timeout 00:01:28.147 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:01:37.768 WIF: Connect failed with AP timeout 00:01:50.789 WIF: Connect failed with AP timeout 00:01:56.146 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:02:05.770 WIF: Connect failed with AP timeout 00:02:18.800 WIF: Connect failed with AP timeout 00:02:24.104 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:02:33.762 WIF: Connect failed with AP timeout 00:02:46.782 WIF: Connect failed with AP timeout 00:02:52.141 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... reset 3 00:02:56.333 CMD: reset 3 00:02:56.340 RSL: RESULT = {"Reset":"Erase, Reset and Restarting"} 00:02:59.633 APP: Restarting

ets Jan 8 2013,rst cause:1, boot mode:(3,6)

load 0x4010f000, len 3584, room 16 tail 0 chksum 0xb0 csum 0xb0 v3969889e ~ld

00:00:00.002 HDW: ESP8266EX 00:00:00.051 CFG: Loaded from flash at F9, Count 59 00:00:00.056 QPC: Count 1 00:00:00.065 Project tasmota - Tasmota Version 10.1.0.1(tasmota)-2_7_4_9(2021-12-12T20:09:35) 00:00:04.400 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:00:06.249 QPC: Reset 00:00:13.787 WIF: Connect failed with AP timeout 00:00:26.802 WIF: Connect failed with AP timeout 00:00:32.097 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:00:41.759 WIF: Connect failed with AP timeout 00:00:54.784 WIF: Connect failed with AP timeout 00:01:00.137 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:01:09.759 WIF: Connect failed with AP timeout seriallog 4 00:01:17.318 CMD: seriallog 4 00:01:17.326 RSL: RESULT = {"SerialLog":{"4":{"Active":"4"}}} 00:01:17.577 CFG: Saved to flash at F7, Count 61, Bytes 4096 00:01:17.767 WIF: Checking connection... 00:01:17.769 WIF: Attempting connection... 00:01:18.768 WIF: Checking connection... 00:01:18.771 WIF: Attempting connection... 00:01:19.771 WIF: Checking connection... 00:01:19.773 WIF: Attempting connection... 00:01:20.774 WIF: Checking connection... 00:01:20.776 WIF: Attempting connection... 00:01:21.777 WIF: Checking connection... 00:01:21.779 WIF: Attempting connection... 00:01:22.777 WIF: Checking connection... 00:01:22.780 WIF: Connect failed with AP timeout 00:01:23.778 WIF: Checking connection... 00:01:23.781 WIF: Attempting connection... 00:01:24.785 WIF: Network (re)scan started... 00:01:24.787 WIF: Checking connection... 00:01:24.789 WIF: Attempting connection... 00:01:25.782 WIF: Checking connection... 00:01:25.785 WIF: Attempting connection... 00:01:26.784 WIF: Checking connection... 00:01:26.786 WIF: Attempting connection... 00:01:27.784 WIF: Network 0, AP2, SSId HLinc2, Channel 6, BSSId 18:31:BF:36:A0:98, RSSI -32, Encryption 1 00:01:27.787 WIF: Network 1, AP2, SSId HLinc2, Channel 6, BSSId E0:3F:49:EE:88:21, RSSI -86, Encryption 1 00:01:27.795 WIF: Network 2, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:52, RSSI -69, Encryption 1 00:01:27.804 WIF: Network 3, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:D1:D6, RSSI -77, Encryption 1 00:01:28.150 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11n as HLso7... 00:01:28.152 WIF: Checking connection... 00:01:28.154 WIF: Attempting connection... 00:01:29.753 WIF: Checking connection... 00:01:29.755 WIF: Attempting connection... 00:01:30.752 WIF: Checking connection... 00:01:30.754 WIF: Attempting connection... 00:01:31.754 WIF: Checking connection... 00:01:31.756 WIF: Attempting connection... 00:01:32.758 WIF: Checking connection... 00:01:32.760 WIF: Attempting connection... 00:01:33.757 WIF: Checking connection... 00:01:33.759 WIF: Attempting connection... 00:01:34.759 WIF: Checking connection... 00:01:34.761 WIF: Attempting connection... 00:01:35.762 WIF: Checking connection... 00:01:35.764 WIF: Attempting connection... 00:01:36.764 WIF: Checking connection... 00:01:36.766 WIF: Attempting connection... 00:01:37.766 WIF: Checking connection... 00:01:37.767 WIF: Connect failed with AP timeout 00:01:38.769 WIF: Checking connection... 00:01:38.771 WIF: Attempting connection... 00:01:39.772 WIF: Checking connection... 00:01:39.774 WIF: Attempting connection... 00:01:40.777 WIF: Checking connection... 00:01:40.779 WIF: Attempting connection... 00:01:41.778 WIF: Checking connection... 00:01:41.781 WIF: Attempting connection... wifi 3 00:01:42.657 CMD: wifi 3 00:01:42.658 SRC: Serial 00:01:42.661 CMD: Grp 0, Cmnd 'WIFI', Idx 1, Len 1, Data '3' 00:01:42.775 RSL: RESULT = {"Wifi":"ON","Mode":"11g"} 00:01:42.846 WIF: Checking connection... 00:01:42.849 WIF: Attempting connection...

ets Jan 8 2013,rst cause:4, boot mode:(3,6)

wdt reset load 0x4010f000, len 3584, room 16 tail 0 chksum 0xb0 csum 0xb0 v3969889e ~ld

00:00:00.001 HDW: ESP8266EX 00:00:00.050 CFG: Loaded from flash at F7, Count 61 00:00:00.056 QPC: Count 1 00:00:00.061 ROT: Mode 1 00:00:00.062 SRC: Restart 00:00:00.064 Project tasmota - Tasmota Version 10.1.0.1(tasmota)-2_7_4_9(2021-12-12T20:09:35) 00:00:00.216 WIF: Checking connection... 00:00:00.217 WIF: Attempting connection... 00:00:01.160 WIF: Network (re)scan started... 00:00:01.161 WIF: Checking connection... 00:00:01.161 WIF: Attempting connection... 00:00:02.160 WIF: Checking connection... 00:00:02.161 WIF: Attempting connection... 00:00:03.163 WIF: Checking connection... 00:00:03.164 WIF: Attempting connection... 00:00:04.167 WIF: Network 0, AP-, SSId Pals netwerk, Channel 1, BSSId B4:FB:E4:74:5E:56, RSSI -86, Encryption 1 00:00:04.169 WIF: Network 1, AP-, SSId Pals gast, Channel 1, BSSId B6:FB:E4:74:5E:56, RSSI -86, Encryption 1 00:00:04.177 WIF: Network 2, AP2, SSId HLinc2, Channel 6, BSSId 18:31:BF:36:A0:98, RSSI -34, Encryption 1 00:00:04.186 WIF: Network 3, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:52, RSSI -67, Encryption 1 00:00:04.195 WIF: Network 4, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:D1:D6, RSSI -74, Encryption 1 00:00:04.542 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11g as HLso7... 00:00:04.543 WIF: Checking connection... 00:00:04.545 WIF: Attempting connection... 00:00:05.802 WIF: Checking connection... 00:00:05.803 WIF: Attempting connection... 00:00:06.474 QPC: Reset 00:00:06.768 WIF: Checking connection... 00:00:06.770 WIF: Attempting connection... 00:00:07.769 WIF: Checking connection... 00:00:07.770 WIF: Attempting connection... 00:00:08.422 APP: Boot Count 24 00:00:08.602 CFG: Saved to flash at F6, Count 62, Bytes 4096 00:00:08.799 WIF: Checking connection... 00:00:08.801 WIF: Connected 00:00:09.052 HTP: Web server active on HLso7 with IP address 192.168.2.90 00:00:09.399 WIF: Sending Gratuitous ARP 00:00:09.401 NTP: Synch time... 00:00:09.428 RTC: UTC 2021-12-14T12:27:11, DST 2021-03-28T02:00:00, STD 2021-10-31T03:00:00 13:27:11.000 NTP: Synched 13:27:11.180 CFG: Saved to flash at F5, Count 63, Bytes 4096 13:27:12.015 RSL: INFO1 = {"Info1":{"Module":"Sonoff Basic","Version":"10.1.0.1(tasmota)","FallbackTopic":"cmnd/DVES_AF718E_fb/","GroupTopic":"cmnd/tasmotas/"}} 13:27:12.021 RSL: INFO2 = {"Info2":{"WebServerMode":"Admin","Hostname":"HLso7","IPAddress":"192.168.2.90"}} 13:27:12.030 RSL: INFO3 = {"Info3":{"RestartReason":"Hardware Watchdog"}} 13:27:12.036 RSL: RESULT = {"POWER":"ON"} 13:27:12.040 RSL: POWER = ON 13:27:16.420 RSL: STATE = {"Time":"2021-12-14T13:27:16","Uptime":"0T00:00:16","UptimeSec":16,"Heap":29,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":0,"POWER":"ON","Wifi":{"AP":2,"SSId":"HLinc2","BSSId":"18:31:BF:36:A0:98","Channel":6,"Mode":"11g","RSSI":100,"Signal":-40,"LinkCount":1,"Downtime":"0T00:00:10"}} 13:27:30.786 WIF: Checking connection... 13:27:50.769 WIF: Checking connection... 13:28:02.433 WIF: Sending Gratuitous ARP 13:28:10.798 WIF: Checking connection... 13:28:30.776 WIF: Checking connection... 13:28:50.756 WIF: Checking connection... 13:29:02.423 WIF: Sending Gratuitous ARP 13:29:10.790 WIF: Checking connection... 13:29:30.771 WIF: Checking connection... 13:29:50.754 WIF: Checking connection... 13:30:02.428 WIF: Sending Gratuitous ARP 13:30:10.793 WIF: Checking connection... 13:30:30.786 WIF: Checking connection... 13:30:50.769 WIF: Checking connection... 13:31:02.437 WIF: Sending Gratuitous ARP 13:31:10.796 WIF: Checking connection... 13:31:30.786 WIF: Checking connection... 13:31:50.767 WIF: Checking connection... 13:32:02.436 WIF: Sending Gratuitous ARP 13:32:10.795 WIF: Checking connection... 13:32:16.404 RSL: STATE = {"Time":"2021-12-14T13:32:16","Uptime":"0T00:05:16","UptimeSec":316,"Heap":29,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":0,"POWER":"ON","Wifi":{"AP":2,"SSId":"HLinc2","BSSId":"18:31:BF:36:A0:98","Channel":6,"Mode":"11g","RSSI":100,"Signal":-42,"LinkCount":1,"Downtime":"0T00:00:10"}}

--------------- CUT HERE FOR EXCEPTION DECODER ---------------

Exception (9): epc1=0x40203b4c epc2=0x00000000 epc3=0x00000000 excvaddr=0x4014c9c9 depc=0x00000000

stack>>>

ctx: cont sp: 3ffffdc0 end: 3fffffc0 offset: 0190 3fffff50: 4024c8c5 00000001 3fff1580 4024c8ba
3fffff60: 3fffdad0 3ffefac4 0004d8e5 40203b80
3fffff70: 3fffdad0 00000000 00000002 4023c3ed
3fffff80: 00000000 00000000 00000001 40100a50
3fffff90: 3fffdad0 00000000 3fff1540 3fff1580
3fffffa0: 3fffdad0 00000000 3fff1540 4024b644
3fffffb0: feefeffe feefeffe 3ffe86d4 40101e69
<<<stack<<<

--------------- CUT HERE FOR EXCEPTION DECODER ---------------

ets Jan 8 2013,rst cause:4, boot mode:(3,6)

wdt reset load 0x4010f000, len 3584, room 16 tail 0 chksum 0xb0 csum 0xb0 v3969889e ~ld

00:00:00.002 HDW: ESP8266EX 00:00:00.050 CFG: Loaded from flash at F5, Count 63 00:00:00.056 QPC: Count 1 00:00:00.061 ROT: Mode 1 00:00:00.062 SRC: Restart 00:00:00.065 Project tasmota - Tasmota Version 10.1.0.1(tasmota)-2_7_4_9(2021-12-12T20:09:35) 00:00:00.218 WIF: Checking connection... 00:00:00.218 WIF: Attempting connection... 00:00:01.161 WIF: Network (re)scan started... 00:00:01.162 WIF: Checking connection... 00:00:01.163 WIF: Attempting connection... 00:00:02.161 WIF: Checking connection... 00:00:02.162 WIF: Attempting connection... 00:00:03.161 WIF: Checking connection... 00:00:03.162 WIF: Attempting connection... 00:00:04.164 WIF: Network 0, AP2, SSId HLinc2, Channel 6, BSSId 18:31:BF:36:A0:98, RSSI -70, Encryption 1 00:00:04.165 WIF: Network 1, AP2, SSId HLinc2, Channel 6, BSSId E0:3F:49:EE:88:21, RSSI -80, Encryption 1 00:00:04.172 WIF: Network 2, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:52, RSSI -67, Encryption 1 00:00:04.181 WIF: Network 3, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:D1:D6, RSSI -68, Encryption 1 00:00:04.191 WIF: Network 4, AP-, SSId HLinc3, Channel 11, BSSId 74:DA:88:95:8E:B6, RSSI -91, Encryption 1 00:00:04.537 WIF: Connecting to AP1 HLinc Channel 10 BSSId 28:EE:52:C1:A4:52 in mode 11g as HLso7... 00:00:04.538 WIF: Checking connection... 00:00:04.539 WIF: Attempting connection... 00:00:05.561 CFG: Saved to flash at F4, Count 64, Bytes 4096 00:00:05.798 WIF: Checking connection... 00:00:05.799 WIF: Attempting connection... 00:00:06.395 QPC: Reset 00:00:06.777 WIF: Checking connection... 00:00:06.779 WIF: Attempting connection... 00:00:07.777 WIF: Checking connection... 00:00:07.779 WIF: Connected 00:00:08.029 HTP: Web server active on HLso7 with IP address 192.168.2.90 00:00:08.328 APP: Boot Count 25 00:00:08.329 WIF: Sending Gratuitous ARP 00:00:08.330 NTP: Synch time... 00:00:08.441 RTC: UTC 2021-12-14T12:32:27, DST 2021-03-28T02:00:00, STD 2021-10-31T03:00:00 13:32:27.000 NTP: Synched 13:32:27.168 CFG: Saved to flash at FB, Count 65, Bytes 4096 13:32:28.018 RSL: INFO1 = {"Info1":{"Module":"Sonoff Basic","Version":"10.1.0.1(tasmota)","FallbackTopic":"cmnd/DVES_AF718E_fb/","GroupTopic":"cmnd/tasmotas/"}} 13:32:28.024 RSL: INFO2 = {"Info2":{"WebServerMode":"Admin","Hostname":"HLso7","IPAddress":"192.168.2.90"}} 13:32:28.035 RSL: INFO3 = {"Info3":{"RestartReason":{"Exception":9,"Reason":"Exception","EPC":["40203b4c","00000000","00000000"],"EXCVADDR":"4014c9c9","DEPC":"00000000","CallChain":["4024c8c5","4024c8ba","40203b80","4023c3ed","40100a50","4024b644","40101e69"]}}} 13:32:28.056 RSL: RESULT = {"POWER":"ON"} 13:32:28.059 RSL: POWER = ON 13:32:32.327 RSL: STATE = {"Time":"2021-12-14T13:32:32","Uptime":"0T00:00:15","UptimeSec":15,"Heap":29,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":0,"POWER":"ON","Wifi":{"AP":1,"SSId":"HLinc","BSSId":"28:EE:52:C1:A4:52","Channel":10,"Mode":"11g","RSSI":56,"Signal":-72,"LinkCount":1,"Downtime":"0T00:00:09"}} 13:32:46.786 WIF: Checking connection... 13:33:06.765 WIF: Checking connection... 13:33:19.331 WIF: Sending Gratuitous ARP 13:33:26.794 WIF: Checking connection... 13:33:46.782 WIF: Checking connection... 13:33:47.588 HTP: Main Menu 13:34:06.763 WIF: Checking connection... 13:34:19.309 WIF: Sending Gratuitous ARP 13:34:26.765 WIF: Checking connection... 13:34:46.785 WIF: Checking connection... 13:35:06.793 WIF: Checking connection... 13:35:19.317 WIF: Sending Gratuitous ARP 13:35:26.760 WIF: Checking connection... 13:35:46.782 WIF: Checking connection... 13:36:06.800 WIF: Checking connection... 13:36:19.318 WIF: Sending Gratuitous ARP 13:36:26.784 WIF: Checking connection... 13:36:46.765 WIF: Checking connection... 13:37:06.774 WIF: Checking connection... 13:37:19.307 WIF: Sending Gratuitous ARP 13:37:26.770 WIF: Checking connection... 13:37:32.315 RSL: STATE = {"Time":"2021-12-14T13:37:32","Uptime":"0T00:05:15","UptimeSec":315,"Heap":28,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":0,"POWER":"ON","Wifi":{"AP":1,"SSId":"HLinc","BSSId":"28:EE:52:C1:A4:52","Channel":10,"Mode":"11g","RSSI":52,"Signal":-74,"LinkCount":1,"Downtime":"0T00:00:09"}}

--------------- CUT HERE FOR EXCEPTION DECODER ---------------

Exception (0): epc1=0x40203b3c epc2=0x00000000 epc3=0x00000000 excvaddr=0x4014c9c9 depc=0x00000000

stack>>>

ctx: cont sp: 3ffffdd0 end: 3fffffc0 offset: 0190 3fffff60: 3fffdad0 3ffefac4 0004eca5 40203b9d
3fffff70: 3fffdad0 00000000 00000001 4023c3ed
3fffff80: 00000000 00000000 00000001 40100a50
3fffff90: 3fffdad0 00000000 3fff1540 3fff1580
3fffffa0: 3fffdad0 00000000 3fff1540 4024b644
3fffffb0: feefeffe feefeffe 3ffe86d4 40101e69
<<<stack<<<

--------------- CUT HERE FOR EXCEPTION DECODER ---------------

ets Jan 8 2013,rst cause:4, boot mode:(3,6)

wdt reset load 0x4010f000, len 3584, room 16 tail 0 chksum 0xb0 csum 0xb0 v3969889e ~ld

00:00:00.002 HDW: ESP8266EX 00:00:00.050 CFG: Loaded from flash at FB, Count 65 00:00:00.056 QPC: Count 1 00:00:00.061 ROT: Mode 1 00:00:00.062 SRC: Restart 00:00:00.065 Project tasmota - Tasmota Version 10.1.0.1(tasmota)-2_7_4_9(2021-12-12T20:09:35) 00:00:00.218 WIF: Checking connection... 00:00:00.218 WIF: Attempting connection... 00:00:01.161 WIF: Network (re)scan started... 00:00:01.162 WIF: Checking connection... 00:00:01.162 WIF: Attempting connection... 00:00:02.162 WIF: Checking connection... 00:00:02.163 WIF: Attempting connection... 00:00:03.163 WIF: Checking connection... 00:00:03.164 WIF: Attempting connection... 00:00:04.164 WIF: Network 0, AP-, SSId Pals gast, Channel 1, BSSId B6:FB:E4:74:5E:56, RSSI -87, Encryption 1 00:00:04.165 WIF: Network 1, AP-, SSId Pals netwerk, Channel 1, BSSId B4:FB:E4:74:5E:56, RSSI -87, Encryption 1 00:00:04.173 WIF: Network 2, AP2, SSId HLinc2, Channel 6, BSSId 18:31:BF:36:A0:98, RSSI -42, Encryption 1 00:00:04.182 WIF: Network 3, AP2, SSId HLinc2, Channel 6, BSSId E0:3F:49:EE:88:21, RSSI -65, Encryption 1 00:00:04.192 WIF: Network 4, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:D1:D6, RSSI -72, Encryption 1 00:00:04.201 WIF: Network 5, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:46, RSSI -89, Encryption 1 00:00:04.210 WIF: Network 6, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:52, RSSI -69, Encryption 1 00:00:04.556 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11g as HLso7... 00:00:04.557 WIF: Checking connection... 00:00:04.558 WIF: Attempting connection... 00:00:05.563 CFG: Saved to flash at FA, Count 66, Bytes 4096 00:00:05.752 WIF: Checking connection... 00:00:05.754 WIF: Connected 00:00:06.004 HTP: Web server active on HLso7 with IP address 192.168.2.90 00:00:06.479 QPC: Reset 00:00:06.481 WIF: Sending Gratuitous ARP 00:00:06.483 NTP: Synch time... 00:00:06.521 RTC: UTC 2021-12-14T12:37:48, DST 2021-03-28T02:00:00, STD 2021-10-31T03:00:00 13:37:48.000 NTP: Synched 13:37:48.090 CFG: Saved to flash at F9, Count 67, Bytes 4096 13:37:49.023 RSL: INFO1 = {"Info1":{"Module":"Sonoff Basic","Version":"10.1.0.1(tasmota)","FallbackTopic":"cmnd/DVES_AF718E_fb/","GroupTopic":"cmnd/tasmotas/"}} 13:37:49.029 RSL: INFO2 = {"Info2":{"WebServerMode":"Admin","Hostname":"HLso7","IPAddress":"192.168.2.90"}} 13:37:49.040 RSL: INFO3 = {"Info3":{"RestartReason":{"Exception":0,"Reason":"Exception","EPC":["40203b3c","00000000","00000000"],"EXCVADDR":"4014c9c9","DEPC":"00000000","CallChain":["40203b9d","4023c3ed","40100a50","4024b644","40101e69"]}}} 13:37:49.059 RSL: RESULT = {"POWER":"ON"} 13:37:49.063 RSL: POWER = ON 13:37:50.421 APP: Boot Count 26 13:37:50.597 CFG: Saved to flash at F8, Count 68, Bytes 4096 13:37:53.420 RSL: STATE = {"Time":"2021-12-14T13:37:53","Uptime":"0T00:00:13","UptimeSec":13,"Heap":28,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":0,"POWER":"ON","Wifi":{"AP":2,"SSId":"HLinc2","BSSId":"18:31:BF:36:A0:98","Channel":6,"Mode":"11g","RSSI":100,"Signal":-48,"LinkCount":1,"Downtime":"0T00:00:07"}} 13:38:07.794 WIF: Checking connection...

ets Jan 8 2013,rst cause:4, boot mode:(3,6)

wdt reset load 0x4010f000, len 3584, room 16 tail 0 chksum 0xb0 csum 0xb0 v3969889e ~ld

00:00:00.001 HDW: ESP8266EX 00:00:00.049 CFG: Loaded from flash at F8, Count 68 00:00:00.055 QPC: Count 1 00:00:00.060 ROT: Mode 1 00:00:00.061 SRC: Restart 00:00:00.064 Project tasmota - Tasmota Version 10.1.0.1(tasmota)-2_7_4_9(2021-12-12T20:09:35) 00:00:00.216 WIF: Checking connection... 00:00:00.217 WIF: Attempting connection... 00:00:01.164 WIF: Network (re)scan started... 00:00:01.165 WIF: Checking connection... 00:00:01.165 WIF: Attempting connection... 00:00:02.164 WIF: Checking connection... 00:00:02.165 WIF: Attempting connection... 00:00:03.165 WIF: Checking connection... 00:00:03.166 WIF: Attempting connection... 00:00:04.167 WIF: Network 0, AP-, SSId Pals gast, Channel 1, BSSId B6:FB:E4:74:5E:56, RSSI -89, Encryption 1 00:00:04.168 WIF: Network 1, AP-, SSId Pals netwerk, Channel 1, BSSId B4:FB:E4:74:5E:56, RSSI -86, Encryption 1 00:00:04.176 WIF: Network 2, AP2, SSId HLinc2, Channel 6, BSSId 18:31:BF:36:A0:98, RSSI -37, Encryption 1 00:00:04.185 WIF: Network 3, AP2, SSId HLinc2, Channel 6, BSSId E0:3F:49:EE:88:21, RSSI -73, Encryption 1 00:00:04.195 WIF: Network 4, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:52, RSSI -70, Encryption 1 00:00:04.204 WIF: Network 5, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:A4:46, RSSI -89, Encryption 1 00:00:04.213 WIF: Network 6, AP1, SSId HLinc, Channel 10, BSSId 28:EE:52:C1:D1:D6, RSSI -71, Encryption 1 00:00:04.559 WIF: Connecting to AP2 HLinc2 Channel 6 BSSId 18:31:BF:36:A0:98 in mode 11g as HLso7... 00:00:04.560 WIF: Checking connection... 00:00:04.561 WIF: Attempting connection... 00:00:05.753 WIF: Checking connection... 00:00:05.755 WIF: Connected 00:00:06.005 HTP: Web server active on HLso7 with IP address 192.168.2.90 00:00:06.452 QPC: Reset 00:00:06.453 WIF: Sending Gratuitous ARP 00:00:06.455 NTP: Synch time... 00:00:06.480 RTC: UTC 2021-12-14T12:38:29, DST 2021-03-28T02:00:00, STD 2021-10-31T03:00:00 13:38:29.000 NTP: Synched 13:38:30.038 RSL: INFO1 = {"Info1":{"Module":"Sonoff Basic","Version":"10.1.0.1(tasmota)","FallbackTopic":"cmnd/DVES_AF718E_fb/","GroupTopic":"cmnd/tasmotas/"}} 13:38:30.043 RSL: INFO2 = {"Info2":{"WebServerMode":"Admin","Hostname":"HLso7","IPAddress":"192.168.2.90"}} 13:38:30.052 RSL: INFO3 = {"Info3":{"RestartReason":"Hardware Watchdog"}} 13:38:30.059 RSL: RESULT = {"POWER":"ON"} 13:38:30.062 RSL: POWER = ON



### TO REPRODUCE
Restarted, now with MQTT active

### EXPECTED BEHAVIOUR
_A clear and concise description of what you expected to happen._

### SCREENSHOTS
_If applicable, add screenshots to help explain your problem._

### ADDITIONAL CONTEXT
_Add any other context about the problem here._

**(Please, remember to close the issue when the problem has been addressed)**
ascillato commented 2 years ago

Hi,

There is no need to open new issues for the same problem. You can continue it in your own previous original issue. Doing that is good because in separated issues, it got complex for other users to follow your problem when doing a search.

Exception 0 sometimes is because the power source is not enough or it is a very noisy one. Just for testing and so as to discard a faulty regulator in your device, please, can you try disconnecting it from mains AC and powering directly to the 5Vcc rail or to the 3.3Vcc rail with a good power source?

Jason2866 commented 2 years ago

Do you have a second (spare) one? The issues you encounter looks like a defect device. Sonoff Basic devices are known for dying young... Most fail with a bad power supply, second most reason is faulty flash chip.

Hans-Sh commented 2 years ago

Hi,

There is no need to open new issues for the same problem. You can continue it in your own previous original issue. Doing that is good because in separated issues, it got complex for other users to follow your problem when doing a search.

Exception 0 sometimes is because the power source is not enough or it is a very noisy one. Just for testing and so as to discard a faulty regulator in your device, please, can you try disconnecting it from mains AC and powering directly to the 5Vcc rail or to the 3.3Vcc rail with a good power source?

Txs, The log provided is when it was(still is) connected Serial via PC USB bus AND the Sonoff it self is powered by a breadboard 3,3 Volt 1 Amp Power Supply.

Hans-Sh commented 2 years ago

Ok, will setup a Basic R3 to test in same conditions. Will keep you posted.

Hans-Sh commented 2 years ago

Have flashed (and erased) a Basic R3 with 10.1.0.1. Using Wifi Manager to set AP to HLinc2 (ASUS) failed. 6x power off/on to restart Wifi Manager. Set AP to HLinc (TP-Link network) and it connected easy to it in N mode. Using the web interface to set AP2 to HLinc2 (ASUS) as this is my preferred setup to have a Wifi fallback in case of.. Restart, Device connect to initial used AP1 (Hlinc TP-Link). Did set So56 and So57 to 1 to get the wished behaviour. Device did find the strongest AP (HLinc2 ASUS) as it is 1,5 meter away from it but times out. AND KEEPS TRYING TO CONNECT TO the strongest AP found.And fails, and fails, enless. This gave me the opportunity to fiddle around with my ASUS router:

Back to the reported problem my thought is, as I configured the 2 AP's as above (my preferred setup) It will connect to ASUS if the router is fresh (re)started. If after hours it want/has to reconnect it ends up in this retry loop without success because it keeps connecting to the strongest AP (in my case the ASUS)

Wish, Is it possible to let it connect after X tries to the other AP?

Please let me know what to test /setup. I have a TP-Link 3x Deco M5 mesh and a Asus Mesh (AC2900 main/Rt68U client), several Sonoffs R2, R3, POW, HT16. I would be very pleased to be of any help in this annoying Wifi /Asus issue.

barbudor commented 2 years ago

Wish, Is it possible to let it connect after X tries to the other AP?

wificonfig 4 but AFAIK you can't configure the number of retries before attempting the other one

Hans-Sh commented 2 years ago

Txs, did check. It is in wificonfig 4 as this is default but during this test the device was only trying to connect to the strongest and did not attempt to connect to the other configured AP. 19:29:11.976 CMD: wificonfig 19:29:11.977 SRC: Serial 19:29:11.979 CMD: Grp 0, Cmnd 'WIFICONFIG', Idx 1, Len 0, Data '' 19:29:11.981 RSL: RESULT = {"WifiConfig":{"4":"Retry"}} 19:29:18.012 WIF: Checking connection...

ascillato commented 2 years ago

Please let me know what to test /setup. I have a TP-Link 3x Deco M5 mesh and a Asus Mesh (AC2900 main/Rt68U client), several Sonoffs R2, R3, POW, HT16. I would be very pleased to be of any help in this annoying Wifi /Asus issue.

Sorry, ASUS routers have issues with the wifi routines of Espressif SDK (that are closed source). This SDK is used by the Arduino Core and Tasmota is built on top of all that.

Please, check the discussion https://github.com/arendst/Tasmota/discussions/13623 for extensive information about this and how to workaround it.

Hans-Sh commented 2 years ago

Please let me know what to test /setup. I have a TP-Link 3x Deco M5 mesh and a Asus Mesh (AC2900 main/Rt68U client), several Sonoffs R2, R3, POW, HT16. I would be very pleased to be of any help in this annoying Wifi /Asus issue.

Sorry, ASUS routers have issues with the wifi routines of Espressif SDK (that are closed source). This SDK is used by the Arduino Core and Tasmota is built on top of all that.

Please, check the discussion #13623 for extensive information about this and how to workaround it.

Mmm, pitty, I do not use any Ardino, Just a lot (20+) of Sonoffs. Is my wish (connect to other AP after x failed tries) part of Tasmota or also this SDK?

ascillato2 commented 2 years ago

Arduino is the name of the Core that uses Tasmota (Not the board). Arduino is the code that have several low level functions. No matter which device you use, if you use Tasmota, under Tasmota, the functions are Arduino Core for ESP8266 board. This Core uses the radio routines provided by the manufacturer of the ESP8266 chip. Those are closed source and we can't fix them. So, all the issue with ASUS comes from the SDK (between other things is that the SDK don't have WMM that ASUS enforces as a MUST for 11n mode - other routers are relaxed about WMM requirements and that is why they work without issues).

Hans-Sh commented 2 years ago

Thanks for the explanation.
So my wish is for the Arduino SDK then? I think it is strange to have 2 AP's configure options and no fallback mechanism or is it how Tasmota uses the SDK?

ascillato commented 2 years ago

What Tasmota does with WIFICONFIG being set to 4, is to try to connect to AP1. if AP1 is not available (meaning that it is not in the air), it will try to connect to AP2. Then, if Tasmota is connected to any AP and it disconnects, It will try to connect to the other configured AP.

With ASUS, the issue is that the initial handshake (while trying to connect) is performed but then ASUS asks for WMM and the SDK don't answer anything. So, from Tasmota side, it actually connects but in reality it doesn't.

So, the intended behavior for WIFICONFIG 4 is what you want, but the handshake (being managed in the SDK) is not correct.

You can:

Also, you can check everything discussed in #13623 for more workarounds in this known ASUS issue. Sorry.

Hans-Sh commented 2 years ago

Txs for this very clear explanation. This helps to configure my setup in a way to keep it reliable. Will configure it tomorrow and if acts as described i wiil close this issue.

Op 14 dec. 2021 om 20:34 heeft Adrian Scillato @.***> het volgende geschreven:

 What Tasmota does with WIFICONFIG being set to 4, is to try to connect to AP1. if AP1 is not available (meaning that it is not in the air), it will try to connect to AP2. Then, if Tasmota is connected to any AP and it disconnects, It will try to connect to the other configured AP.

With ASUS, the issue is that the initial handshake while trying to connect is performed but then ASUS asks for WMM and the SDK don't answer anything. So, from Tasmota side, it actually connects but in reality it doesn't.

So, the intended behavior for WIFICONFIG 4 is what you want, but the handshake (being managed in the SDK) is not correct.

You can:

Set your router to allow b/g/n disable WMM put a different SSID to 5Ghz and disable band steering Set the command wifi 3 in Tasmota to disable mode 11n Disable So56 and So57 and set Tasmota to connect to the router you already know has the higher strength. Also, you can check everything discussed in #13623 for more workarounds.

— You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe. Triage notifications on the go with GitHub Mobile for iOS or Android.

Jason2866 commented 2 years ago

Closing since the original issue is solved -> hardware issue.

Hans-Sh commented 2 years ago

Sorry @Jason2866. It wasn't a hardware issue. It was caused by the known Arduino SDK / ASUS router Problem. Workaround for me is to use Wifi 3 (if 9.5.0 and up) and wait for: https://github.com/esp8266/Arduino/pull/8319 and the Tasmota development thereafter. Thanks for all who helped to analyse my issue and to have it related to the existing mentioned Arduino SDK (2.5.2 and higher) without doubts.

Jason2866 commented 2 years ago

The PR https://github.com/esp8266/Arduino/pull/8319 does not solve the Asus issues. See tests in #13623 So at the end it is a hardware issue (replace ASUS) when you want to solve.