[NG firmware] Deadlock in SoftAP mode

[MartinHruza]

Checklist

• Checked the issue tracker for similar issues to ensure this is not a duplicate
• Read the documentation to confirm the issue is not addressed there and your configuration is set correctly
• Tested with the latest version to ensure the issue hasn't been fixed

How often does this bug occurs?

often

Expected behavior

A client succesfully connects to the ESP32 AP.

Actual behavior (suspected bug)

After couple of retries the client gives up and esp32 deadlocks.
Some clients are more successful and sometimes do connect.

Error logs or terminal output

Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437090) FW_CMD: Disconnect request: reason [2], interface=1
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437090) wifi:station: dc:41:a9:36:e9:8a leave, AID = 2, bss_flags is 3136, bss:0x40851be4
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437098) wifi:ifidx:1, rssi:0, nf:-95, phytype(0x2, CBW20-LGI), phymode(0x3, 11bgn), max_rate:0, he:0
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437107) wifi:max ampdu length exponent:3(65535 bytes), mmss:5(4 us)
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437113) wifi:new:<1,0>, old:<1,0>, ap:<1,1>, sta:<0,0>, prof:1
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437180) FW_MAIN: AP station command
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437180) FW_CMD: process_ap_station:got station add command
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437180) mac: 0x4081f46c   dc 41 a9 36 e9 8a                                 |.A.6..|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437188) FW_CMD: aid=0
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437192) supported_rates: 0x4081f48c   00 00 00 00 00 00 00 00  00 00 00 00              |............|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437202) ht_rates: 0x4081f498   00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  |................|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437212) ht_rates: 0x4081f4a8   00 00 00 00 00 00 00 00  00 00 00 00              |............|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437222) vht_rates: 0x4081f4b4   00 00 00 00 00 00 00 00  00 00 00 00 00 00        |..............|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437232) he_rates: 0x4081f4c4   00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  |................|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437242) he_rates: 0x4081f4d4   00 00 00 00 00 00 00 00  00 00 00                 |...........|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437251) FW_CMD: add_station_node_ap: not station add cmd, handle later
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437330) FW_MAIN: AP station command
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437330) FW_CMD: process_ap_station:got station add command
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437330) mac: 0x4081fc6c   dc 41 a9 36 e9 8a                                 |.A.6..|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437338) FW_CMD: aid=0
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437342) supported_rates: 0x4081fc8c   00 00 00 00 00 00 00 00  00 00 00 00              |............|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437352) ht_rates: 0x4081fc98   00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  |................|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437362) ht_rates: 0x4081fca8   00 00 00 00 00 00 00 00  00 00 00 00              |............|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437372) vht_rates: 0x4081fcb4   00 00 00 00 00 00 00 00  00 00 00 00 00 00        |..............|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437382) he_rates: 0x4081fcc4   00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  |................|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437391) he_rates: 0x4081fcd4   00 00 00 00 00 00 00 00  00 00 00                 |...........|
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: I (437401) FW_CMD: add_station_node_ap: authrizing station
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]: E (437407) wifi:ieee80211_supplicant.c 355
Fri Dec 13 21:36:41 2024 daemon.info esp32-fw-log[730]:
Fri Dec 13 21:36:46 2024 kern.err kernel: [  455.849041] esp32_sdio: wait_and_decode_cmd_resp: Command[0x1A] timed out
Fri Dec 13 21:36:46 2024 kern.err kernel: [  455.854439] esp32_sdio: cmd_add_station: wait_and_decode_cmd_resp(priv, cmd_node) failure, ret: -22
Fri Dec 13 21:36:46 2024 daemon.info hostapd: wlan0: STA dc:41:a9:36:e9:8a RADIUS: starting accounting session 73BA408E69001526
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: E (442329) task_wdt: Task watchdog got triggered. The following tasks/users did not reset the watchdog in time:
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: E (442329) task_wdt:  - IDLE (CPU 0)
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: E (442329) task_wdt: Tasks currently running:
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: E (442329) task_wdt: CPU 0: wifi
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: E (442329) task_wdt: Print CPU 0 (current core) registers
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: Core �0 register dump:
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: MEPC    : 0x42071c8c  RA      : 0x42071c8c  SP      : 0x40831c40  GP      : 0x4081a4f0
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: TP      : 0x4080f98c  T0      : 0x40028192  T1      : 0x4083182c  T2      : 0x01012c00
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: S0/FP   : 0x4081fc64  S1      : 0x4081fc8c  A0      : 0x00000001  A1      : 0x40831808
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: A2      : 0x00000000  A3      : 0x00000017  A4      : 0x4082c000  A5      : 0x00000000
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: A6      : 0x00000001  A7      : 0x0000000a  S2      : 0x4081fc6c  S3      : 0x4081fc98
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: S4      : 0x4081fcb4  S5      : 0x4081fcc4  S6      : 0x40880000  S7      : 0x40880000
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: S8      : 0x40880000  S9      : 0x00000000  S10     : 0x00000000  S11     : 0x00000000
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: T3      : 0x00000000  T4      : 0x00000cc7  T5      : 0x1aff0000  T6      : 0x00000000
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: MSTATUS : 0x40880000  MTVEC   : 0x4081fcc4  MCAUSE  : 0x4081fc64  MTVAL   : 0x0006ac99
Fri Dec 13 21:36:46 2024 daemon.info esp32-fw-log[730]: MHARTID : 0x420b4bf8
Fri Dec 13 21:36:51 2024 kern.err kernel: [  460.889048] esp32_sdio: wait_and_decode_cmd_resp: Command[0x17] timed out
Fri Dec 13 21:36:51 2024 kern.err kernel: [  460.894449] esp32_sdio: cmd_set_ie: wait_and_decode_cmd_resp(priv, cmd_node) failure, ret: -22

Steps to reproduce the behavior

Setup WiFi AP with no password and try to connect some client device

Project release version

latest master

System architecture

ARM 32-bit (Raspberry Pi 32-bit)

Operating system

Linux

Operating system version

Ubuntu 24.04

Shell

Bash

Additional context

No response

[mantriyogesh]

@kapilkedawat ++

[MartinHruza]

Seems like one or both of these two commits helped and it works now, thanks!

d44a553
f9b713f

[mantriyogesh]

Can we close this issue @MartinHruza , considering these commits are already present in master?