[FS#1074] NETDEV WATCHDOG: wlan2 (mwifiex_sdio): transmit queue 1 timed out - WRT3200ACM

[LEDE Bugs]

A new Flyspray task has been opened.  Details are below. 

User who did this - ratsputin (ratsputin) 

Attached to Project - LEDE Project
Summary - NETDEV WATCHDOG: wlan2 (mwifiex_sdio): transmit queue 1 timed out - WRT3200ACM
Task Type - Bug Report
Category - Base system
Status - Unconfirmed
Assigned To - 
Operating System - All
Severity - Critical
Priority - Very Low
Reported Version - Trunk
Due in Version - Undecided
Due Date - Undecided
Details -  - Device problem occurs on: WRT3200ACM
 - Software versions of LEDE release, packages, etc.: LEDE Reboot SNAPSHOT r5096-a29848c / LuCI Master (git-17.260.43176-678c15c)
 - Steps to reproduce: I've been consistently having problems with wlan2 going offline after the router has been up for a day or so, but just stumbled across this in dmesg.  I'll see if I can figure out the circumstances leading to it.
   

[85338.316517] WARNING: CPU: 1 PID: 0 at net/sched/sch_generic.c:316 dev_watchdog+0x1b4/0x234
[85338.324820] NETDEV WATCHDOG: wlan2 (mwifiex_sdio): transmit queue 1 timed out
[85338.331987] Modules linked in: pppoe ppp_async pppox ppp_generic nf_conntrack_ipv6 iptable_nat ipt_REJECT ipt_MASQUERADE xt_time xt_tcpudp xt_tcpmss xt_statistic xt_state xt_recent xt_nat xt_multiport xt_mark xt_mac xt_limit xt_length xt_hl xt_helper xt_ecn xt_dscp xt_conntrack xt_connmark xt_connlimit xt_connbytes xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_HL xt_DSCP xt_CLASSIFY slhc rfcomm nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack mwifiex_sdio mwifiex iptable_mangle iptable_filter ipt_ECN ip_tables hidp hci_uart crc_ccitt btusb btmrvl_sdio btmrvl btintel bnep bluetooth hid evdev input_core mwlwifi mac80211 cfg80211 compat xt_set ip_set_list_set ip_set_hash_netiface ip_set_hash_netport
[85338.404541]  ip_set_hash_netnet ip_set_hash_net ip_set_hash_netportnet ip_set_hash_mac ip_set_hash_ipportnet ip_set_hash_ipportip ip_set_hash_ipport ip_set_hash_ipmark ip_set_hash_ip ip_set_bitmap_port ip_set_bitmap_ipmac ip_set_bitmap_ip ip_set nfnetlink ip6t_REJECT nf_reject_ipv6 nf_log_ipv6 nf_log_common ip6table_mangle ip6table_filter ip6_tables x_tables tun regmap_mmio ecb cmac uhci_hcd ohci_platform ohci_hcd gpio_button_hotplug
[85338.442106] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.9.54 #0
[85338.448049] Hardware name: Marvell Armada 380/385 (Device Tree)
[85338.454003] [] (unwind_backtrace) from [] (show_stack+0x10/0x14)
[85338.461782] [] (show_stack) from [] (dump_stack+0x7c/0x9c)
[85338.469036] [] (dump_stack) from [] (__warn+0xbc/0xec)
[85338.475939] [] (__warn) from [] (warn_slowpath_fmt+0x34/0x44)
[85338.483455] [] (warn_slowpath_fmt) from [] (dev_watchdog+0x1b4/0x234)
[85338.491661] [] (dev_watchdog) from [] (call_timer_fn+0x20/0x94)
[85338.499349] [] (call_timer_fn) from [] (run_timer_softirq+0x1c4/0x200)
[85338.507650] [] (run_timer_softirq) from [] (__do_softirq+0xd0/0x204)
[85338.515775] [] (__do_softirq) from [] (irq_exit+0x94/0xb8)
[85338.523029] [] (irq_exit) from [] (__handle_domain_irq+0x90/0xb4)
[85338.530892] [] (__handle_domain_irq) from [] (gic_handle_irq+0x50/0x94)
[85338.539277] [] (gic_handle_irq) from [] (__irq_svc+0x6c/0x90)
[85338.546789] Exception stack(0xdf475f90 to 0xdf475fd8)
[85338.551860] 5f80:                                     00000001 00000000 00000000 c001b1c0
[85338.560071] 5fa0: 00000000 df474000 c0604fe4 00000002 c05ff168 00000000 df475fe8 00000001
[85338.568282] 5fc0: 00000000 df475fe0 c000f808 c000f80c 60000013 ffffffff
[85338.574925] [] (__irq_svc) from [] (arch_cpu_idle+0x2c/0x38)
[85338.582355] [] (arch_cpu_idle) from [] (cpu_startup_entry+0xf0/0x19c)
[85338.590567] [] (cpu_startup_entry) from [] (0x95ac)
[85338.597214] ---[ end trace 7ee504210e2aead0 ]---
[85338.601865] mwifiex_sdio mmc0:0001:1: 8504333 : Tx timeout(#1), bss_type-num = 1-0
[85344.871433] mwifiex_sdio mmc0:0001:1: 8504960 : Tx timeout(#2), bss_type-num = 1-0
[85350.631045] mwifiex_sdio mmc0:0001:1: 8505536 : Tx timeout(#3), bss_type-num = 1-0
[85356.400657] mwifiex_sdio mmc0:0001:1: 8506113 : Tx timeout(#4), bss_type-num = 1-0
[85366.309996] mwifiex_sdio mmc0:0001:1: 8507104 : Tx timeout(#5), bss_type-num = 1-0
[85376.309327] mwifiex_sdio mmc0:0001:1: 8508104 : Tx timeout(#6), bss_type-num = 1-0
[85386.318652] mwifiex_sdio mmc0:0001:1: 8509105 : Tx timeout(#7), bss_type-num = 1-0
[85386.326257] mwifiex_sdio mmc0:0001:1: tx_timeout_cnt exceeds threshold.      Triggering card reset!
[85386.356950] mwifiex_sdio mmc0:0001:1: info: shutdown mwifiex...
[85386.362967] mwifiex_sdio mmc0:0001:1: PREP_CMD: card is removed
[85386.368924] mwifiex_sdio mmc0:0001:1: Failed to delete mgmt IEs!
[85386.374978] mwifiex_sdio mmc0:0001:1: PREP_CMD: card is removed
[85386.380928] mwifiex_sdio mmc0:0001:1: Failed to stop the BSS
[85386.387009] br-lan: port 4(wlan2) entered disabled state
[85386.394495] device wlan2 left promiscuous mode
[85386.398975] br-lan: port 4(wlan2) entered disabled state
[85386.404593] mwifiex_sdio mmc0:0001:1: PREP_CMD: card is removed
[85386.410562] mwifiex_sdio mmc0:0001:1: PREP_CMD: card is removed
[85386.416507] mwifiex_sdio mmc0:0001:1: PREP_CMD: card is removed
[85386.603147] mwifiex_sdio mmc0:0001:1: WLAN FW already running! Skip FW dnld
[85386.610161] mwifiex_sdio mmc0:0001:1: WLAN FW is active
[85396.707953] mwifiex_sdio mmc0:0001:1: mwifiex_cmd_timeout_func: Timeout cmd id = 0xa9, act = 0x0
[85396.716787] mwifiex_sdio mmc0:0001:1: num_data_h2c_failure = 0
[85396.722652] mwifiex_sdio mmc0:0001:1: num_cmd_h2c_failure = 0
[85396.728423] mwifiex_sdio mmc0:0001:1: is_cmd_timedout = 1
[85396.733842] mwifiex_sdio mmc0:0001:1: num_tx_timeout = 0
[85396.739178] mwifiex_sdio mmc0:0001:1: last_cmd_index = 3
[85396.744512] mwifiex_sdio mmc0:0001:1: last_cmd_id: b3 00 b3 00 b2 00 a9 00 b3 00
[85396.751940] mwifiex_sdio mmc0:0001:1: last_cmd_act: 00 00 00 00 00 00 00 00 00 00
[85396.759457] mwifiex_sdio mmc0:0001:1: last_cmd_resp_index = 2
[85396.765225] mwifiex_sdio mmc0:0001:1: last_cmd_resp_id: b3 80 b3 80 b2 80 b3 80 b3 80
[85396.773093] mwifiex_sdio mmc0:0001:1: last_event_index = 2
[85396.778603] mwifiex_sdio mmc0:0001:1: last_event: 37 00 55 00 43 00 55 00 55 00
[85396.785944] mwifiex_sdio mmc0:0001:1: data_sent=1 cmd_sent=1
[85396.791630] mwifiex_sdio mmc0:0001:1: ps_mode=0 ps_state=0
[85396.797372] mwifiex_sdio mmc0:0001:1: info: _mwifiex_fw_dpc: unregister device



More information can be found at the following URL:
https://bugs.lede-project.org/index.php?do=details&task_id=1074