Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

FS#2220 - ath10k NEW kernel thread crash in CT htt firmware - ath10k unusable after 50k seconds #7060

Open
openwrt-bot opened this issue Apr 3, 2019 · 2 comments
Labels

Comments

@openwrt-bot
Copy link

pleasantone:

OpenWrt SNAPSHOT, r9754-fbe2e7d15e
Trunk Pulled April 1st.
Archer C7v2

Unclear how to reproduce, just happens.

Supplying init logs and kernel trace logs:

[ 31.099086] ath10k 4.19 driver, optimized for CT firmware, probing pci device: 0x3c.
[ 31.108127] PCI: Enabling device 0000:00:00.0 (0000 -> 0002)
[ 31.116173] ath10k_pci 0000:00:00.0: pci irq legacy oper_irq_mode 1 irq_mode 0 reset_mode 0
[ 31.389333] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/fwcfg-pci-0000:00:00.0.txt failed with error -2
[ 31.400044] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 31.491602] firmware ath10k!fwcfg-pci-0000:00:00.0.txt: firmware_loading_store: map pages failed
[ 31.500774] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/pre-cal-pci-0000:00:00.0.bin failed with error -2
[ 31.511656] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 31.687486] firmware ath10k!pre-cal-pci-0000:00:00.0.bin: firmware_loading_store: map pages failed
[ 31.696848] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/cal-pci-0000:00:00.0.bin failed with error -2
[ 31.707378] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 31.949406] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/ct-firmware-5.bin failed with error -2
[ 31.960559] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 32.095183] firmware ath10k!QCA988X!hw2.0!ct-firmware-5.bin: firmware_loading_store: map pages failed
[ 32.104800] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/ct-firmware-2.bin failed with error -2
[ 32.115944] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 32.291783] firmware ath10k!QCA988X!hw2.0!ct-firmware-2.bin: firmware_loading_store: map pages failed
[ 32.301402] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-6.bin failed with error -2
[ 32.312279] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 32.487841] firmware ath10k!QCA988X!hw2.0!firmware-6.bin: firmware_loading_store: map pages failed
[ 32.497209] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-5.bin failed with error -2
[ 32.508092] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 32.684408] firmware ath10k!QCA988X!hw2.0!firmware-5.bin: firmware_loading_store: map pages failed
[ 32.693770] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-4.bin failed with error -2
[ 32.704646] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 32.879819] firmware ath10k!QCA988X!hw2.0!firmware-4.bin: firmware_loading_store: map pages failed
[ 32.889172] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-3.bin failed with error -2
[ 32.900050] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 33.076143] firmware ath10k!QCA988X!hw2.0!firmware-3.bin: firmware_loading_store: map pages failed
[ 33.089091] ath10k_pci 0000:00:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
[ 33.098473] ath10k_pci 0000:00:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 1 testmode 0
[ 33.110860] ath10k_pci 0000:00:00.0: firmware ver 10.1-ct-8x-__fW-022-883e26a8 api 2 features wmi-10.x,has-wmi-mgmt-tx,mfp,txstatus-noack,wmi-10.x-CT,ratemask-CT,txrate-CT,get-temp-CT,tx-rc-CT,cust-stats-CT,retry-gt2-CT,txrate2-CT,beacon-cb-CT crc32 7a67ce60
[ 33.219987] ath10k_pci 0000:00:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/board-2.bin failed with error -2
[ 33.230599] ath10k_pci 0000:00:00.0: Falling back to user helper
[ 33.382851] firmware ath10k!QCA988X!hw2.0!board-2.bin: firmware_loading_store: map pages failed
[ 33.392104] ath10k_pci 0000:00:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
[ 34.332647] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16 peers: 127 tid: 256
[ 34.350100] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
[ 34.356422] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424 sw-crypt: 0 ct-sta: 0'
[ 34.364543] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 24680 iram: 26872'
[ 34.432688] ath10k_pci 0000:00:00.0: htt-ver 2.1 wmi-op 2 htt-op 2 cal file max-sta 128 raw 0 hwcrypto 1
[ 34.445504] ath10k_pci 0000:00:00.0: NOTE: Firmware DBGLOG output disabled in debug_mask: 0x10000000
[ 34.579131] ath: EEPROM regdomain: 0x0
[ 34.579137] ath: EEPROM indicates default country code should be used
[ 34.579140] ath: doing EEPROM country->regdmn map search
[ 34.579152] ath: country maps to regdmn code: 0x3a
[ 34.579158] ath: Country alpha2 being used: US
[ 34.579161] ath: Regpair used: 0x3a
[ 34.652355] ath: EEPROM regdomain: 0x0
[ 34.652362] ath: EEPROM indicates default country code should be used
[ 34.652365] ath: doing EEPROM country->regdmn map search
[ 34.652378] ath: country maps to regdmn code: 0x3a
[ 34.652383] ath: Country alpha2 being used: US
[ 34.652386] ath: Regpair used: 0x3a
[ 34.669837] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
[ 34.671315] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=12

50893 seconds later:

[50893.910674] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50893.961879] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.015322] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.064267] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.115474] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.166670] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.217864] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.269072] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.320275] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.371474] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.422686] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.473885] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.525096] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.576362] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.627495] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.678696] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.732123] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.781096] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.834596] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.883493] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[50894.934705] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50894.985904] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
...repeats...
[50896.978515] ath10k_pci 0000:00:00.0: wmi command 36954 timeout, restarting hardware
[50896.986336] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50897.033922] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
...repeats...
[50900.018475] ath10k_pci 0000:00:00.0: wmi command 40859 timeout, restarting hardware
[50900.026455] ath10k_pci 0000:00:00.0: failed to send wmi nop: -11
[50900.032989] ath10k_pci 0000:00:00.0: failed to send pdev bss chan info request: -143
[50900.048476] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 87385a00 vdev: 0 addr: 50:f5:da:36:35:2c
[50900.059639] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 85914a00 vdev: 0 addr: ac:bc:32:b4:c4:d7
[50900.070766] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 86c43400 vdev: 1 addr: 32:b5:c2:96:62:fd
[50900.081883] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 86e1f000 vdev: 0 addr: 30:b5:c2:96:62:fd
[50900.093145] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[50900.355684] ieee80211 phy0: Hardware restart was requested
[50900.361749] ath10k_pci 0000:00:00.0: failed to set beacon mode for vdev 1: -143
[50900.369442] ath10k_pci 0000:00:00.0: failed to set dtim period for vdev 1: -143
[50901.941908] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16 peers: 127 tid: 256
[50901.959432] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
[50901.965928] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424 sw-crypt: 0 ct-sta: 0'
[50901.974101] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 24680 iram: 26872'
[50902.043511] ath10k_pci 0000:00:00.0: pdev param 0 not supported by firmware
[50902.058893] ath10k_pci 0000:00:00.0: set-coverage-class, phyclk: 88 value: 0
[50902.079716] ath10k_pci 0000:00:00.0: device successfully recovered
[50902.086147] ath10k_pci 0000:00:00.0: Invalid state: 3 in ath10k_htt_tx_32, warning will not be repeated.
[50902.086152] ------------[ cut here ]------------
[50902.086232] WARNING: CPU: 0 PID: 4533 at /home/vagrant/openwrt/build_dir/target-mips_24kc_musl/linux-ath79_generic/ath10k-ct-2019-03-25-2e917efb/ath10k-4.19/htt_tx.c:1253 ath10k_convert_hw_rate_to_rate_info+0x190/0xae4 [ath10k_core]
[50902.086235] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw ath10k_pci ath10k_core ath pppox ppp_generic nf_conntrack_ipv6 mac80211 iptable_nat ipt_REJECT ipt_MASQUERADE cfg80211 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_TRACE xt_TCPMSS xt_REDIRECT xt_LOG xt_HL xt_FLOWOFFLOAD xt_DSCP xt_CT xt_CLASSIFY slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_flow_table_hw nf_flow_table nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack_netlink iptable_raw iptable_mangle iptable_filter ipt_ECN ip6table_raw ip_tables crc_ccitt compat sch_cake nf_conntrack
[50902.086394] sch_tbf sch_ingress sch_htb sch_hfsc em_u32 cls_u32 cls_tcindex cls_route cls_matchall cls_fw cls_flow cls_basic act_skbedit act_mirred ledtrig_usbport xt_set ip_set_list_set ip_set_hash_netportnet ip_set_hash_netport ip_set_hash_netnet ip_set_hash_netiface ip_set_hash_net 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 nf_log_ipv6 nf_log_common ip6table_mangle ip6table_filter ip6_tables ip6t_REJECT x_tables nf_reject_ipv6 ifb tun ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common
[50902.086515] CPU: 0 PID: 4533 Comm: kworker/0:1 Not tainted 4.14.109 #0
[50902.086640] Workqueue: events_freezable ieee80211_alloc_hw_nm [mac80211]
[50902.086644] Stack : 00000009 000004e5 87d58468 800b2878 804aeb00 87c07cb4 85da4ddc 80501947
[50902.086665] 804aac3c 87c07c8c 80500000 800b36d4 87d58468 00000000 87c07c68 dabdb416
[50902.086684] 00000000 00000000 00000000 00000000 00000004 8040f32c 00000001 68775f6e
[50902.086702] 735f6672 80500000 000001be 65657a61 00000000 00000000 87154274 87124968
[50902.086721] 00000009 000004e5 87d58468 8723cbf0 00000000 00000000 00000000 80650000
[50902.086739] ...
[50902.086745] Call Trace:
[50902.086767] [<8006a90c>] show_stack+0x58/0x100
[50902.086791] [<80084fa0>] __warn+0xe4/0x118
[50902.086802] [<80085064>] warn_slowpath_null+0x1c/0x28
[50902.086866] [<87124968>] ath10k_convert_hw_rate_to_rate_info+0x190/0xae4 [ath10k_core]
[50902.086896] [<87103d04>] 0x87103d04
[50902.086913] ---[ end trace db720eb818c982c2 ]---
[50902.086925] ath10k_pci 0000:00:00.0: failed to transmit packet, dropping: -19
[50902.086938] ath10k_pci 0000:00:00.0: failed to submit frame: -19
[50902.086945] ath10k_pci 0000:00:00.0: failed to push frame: -19
[50902.086967] ath10k_pci 0000:00:00.0: failed to transmit packet, dropping: -19
[50902.086977] ath10k_pci 0000:00:00.0: failed to submit frame: -19
[50902.086984] ath10k_pci 0000:00:00.0: failed to push frame: -19
[50902.097084] ath10k_pci 0000:00:00.0: failed to transmit packet, dropping: -19
...repeats...
[55789.947757] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55789.998968] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
55792.860153] ath10k_pci 0000:00:00.0: wmi command 36893 timeout, restarting hardware
[55792.867970] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55792.875741] ath10k_pci 0000:00:00.0: failed to delete peer b0:19:c6:64:f9:69 for vdev 0: -11
[55792.884453] ath10k_pci 0000:00:00.0: found sta peer b0:19:c6:64:f9:69 (ptr 86e1f600 id 33) entry on vdev 0 after it was supposedly removed
[55792.897563] ------------[ cut here ]------------
[55792.902662] WARNING: CPU: 0 PID: 2420 at backports-4.19.23-1/net/mac80211/sta_info.c:1004 sta_set_sinfo+0xbac/0xc58 [mac80211]
[55792.914415] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw ath10k_pci ath10k_core ath pppox ppp_generic nf_conntrack_ipv6 mac80211 iptable_nat ipt_REJECT ipt_MASQUERADE cfg80211 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_TRACE xt_TCPMSS xt_REDIRECT xt_LOG xt_HL xt_FLOWOFFLOAD xt_DSCP xt_CT xt_CLASSIFY slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_flow_table_hw nf_flow_table nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack_netlink iptable_raw iptable_mangle iptable_filter ipt_ECN ip6table_raw ip_tables crc_ccitt compat sch_cake nf_conntrack
[55792.986359] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55792.986485] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55793.003634] sch_tbf sch_ingress sch_htb sch_hfsc em_u32 cls_u32 cls_tcindex cls_route cls_matchall cls_fw cls_flow cls_basic act_skbedit act_mirred ledtrig_usbport xt_set ip_set_list_set ip_set_hash_netportnet ip_set_hash_netport ip_set_hash_netnet ip_set_hash_netiface ip_set_hash_net 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 nf_log_ipv6 nf_log_common ip6table_mangle ip6table_filter ip6_tables ip6t_REJECT x_tables nf_reject_ipv6 ifb tun ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common
[55793.062374] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55793.070938] CPU: 0 PID: 2420 Comm: hostapd Tainted: G W 4.14.109 #0
[55793.078506] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55793.086883] Stack : 80520000 804d84a4 00000000 00000000 804aeb00 85da1b04 87dd02dc 80501947
[55793.095767] 804aacd0 00000974 80653670 000003ec 85da1cb4 00000001 85da1ab8 b78f71e9
[55793.104653] 00000000 00000000 80650000 00012a38 00000000 00000000 00000008 00000000
[55793.114085] 000002ce 861a1102 000002cc 00000000 80000000 00000000 87064a04 87007c2c
[55793.123006] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55793.131158] 00000009 000003ec 85da1cb4 87ff8800 00000002 802697c4 00000000 80650000
[55793.139658] ...
[55793.142953] Call Trace:
[55793.145468] [<8006a90c>] show_stack+0x58/0x100
[55793.149997] [<80084fa0>] __warn+0xe4/0x118
[55793.154512] [<80085064>] warn_slowpath_null+0x1c/0x28
[55793.160292] [<87007c2c>] sta_set_sinfo+0xbac/0xc58 [mac80211]
[55793.166181] [<87007db8>] sta_info_destroy_addr_bss+0x38/0x60 [mac80211]
[55793.173452] [<8778f17c>] cfg80211_check_station_change+0x1be0/0x2c54 [cfg80211]
[55793.180959] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55793.188700] ---[ end trace db720eb818c982c3 ]---
[55793.224635] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55793.275831] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
...
[55796.220118] ath10k_pci 0000:00:00.0: wmi command 36954 timeout, restarting hardware
[55796.245481] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55796.296663] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55796.317807] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 8561b600 vdev: 0 addr: 50:f5:da:36:35:2c
[55796.328987] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 85322c00 vdev: 0 addr: ac:bc:32:b4:c4:d7
[55796.340121] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 834fb200 vdev: 1 addr: 32:b5:c2:96:62:fd
[55796.351253] ath10k_pci 0000:00:00.0: removing peer, cleanup-all, deleting: peer 834fb000 vdev: 0 addr: 30:b5:c2:96:62:fd
[55796.860635] irq 15: nobody cared (try booting with the "irqpoll" option)
[55796.867447] CPU: 0 PID: 15620 Comm: kworker/u2:0 Tainted: G W 4.14.109 #0
[55796.875540] Workqueue: ath10k_wq ath10k_core_create [ath10k_core]
[55796.881718] Stack : ffffffff 00000003 80653ae0 800b2878 804aeb00 87c07cc4 86e123dc 80501947
[55796.890201] 804aac3c 87c07c9c 80500000 800b36d4 80653ae0 00000000 87c07c78 86c8eb6e
[55796.898683] 00000000 00000000 00000000 000151c0 00000000 00000000 00000008 00000000
[55796.907167] 00000323 80500000 00000322 00000000 00000000 8050b6a4 0000000f 00011000
[55796.915650] ffffffff 00000003 80653ae0 80506ae8 00000000 802697c4 00000000 80650000
[55796.924134] ...
[55796.926615] Call Trace:
[55796.929112] [<8006a90c>] show_stack+0x58/0x100
[55796.933620] [<800b6f6c>] __report_bad_irq.isra.0+0x54/0xf0
[55796.939179] [<800b72f4>] note_interrupt+0x284/0x330
[55796.944142] [<800b488c>] handle_irq_event_percpu+0x4c/0x64
[55796.949706] [<800b48e0>] handle_irq_event+0x3c/0x6c
[55796.954650] [<800b7ca4>] handle_level_irq+0x110/0x154
[55796.959772] [<800b3d90>] generic_handle_irq+0x38/0x50
[55796.964903] [<802d4750>] ar724x_pci_irq_handler+0xa4/0xdc
[55796.970376] [<800b3d90>] generic_handle_irq+0x38/0x50
[55796.975502] [<80219354>] ath79_intc_irq_handler+0x94/0xec
[55796.980981] [<800b3d90>] generic_handle_irq+0x38/0x50
[55796.986117] [<804144d4>] do_IRQ+0x1c/0x2c
[55796.990185] [<80219260>] plat_irq_dispatch+0xc0/0x120
[55796.995306] [<800658d8>] handle_int+0x138/0x144
[55796.999900] [<80219260>] plat_irq_dispatch+0xc0/0x120
[55797.005018] handlers:
[55797.007333] [<877134a0>] ath10k_pci_irq_msi_fw_mask [ath10k_pci]
[55797.013420] Disabling IRQ #15
[55797.285000] ieee80211 phy0: Hardware restart was requested
[55800.300248] ath10k_pci 0000:00:00.0: bss channel survey timed out
[55801.740207] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16 peers: 127 tid: 256
[55801.850097] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
[55801.856213] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424 sw-crypt: 0 ct-sta: 0'
[55801.864353] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 24680 iram: 26872'
[55802.950176] ath10k_pci 0000:00:00.0: pdev param 0 not supported by firmware
[55808.120391] ath10k_pci 0000:00:00.0: device successfully recovered
[55808.126726] net_ratelimit: 79 callbacks suppressed
[55808.126736] ath10k_pci 0000:00:00.0: failed to transmit packet, dropping: -19
[55808.126748] ath10k_pci 0000:00:00.0: failed to submit frame: -19
[55808.126756] ath10k_pci 0000:00:00.0: failed to push frame: -19
[55808.126771] ath10k_pci 0000:00:00.0: failed to transmit packet, dropping: -19
[55808.126780] ath10k_pci 0000:00:00.0: failed to submit frame: -19
[55808.126787] ath10k_pci 0000:00:00.0: failed to push frame: -19
[55808.560031] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55808.567607] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55808.575152] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55808.670084] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55808.677616] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55808.790161] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55808.797700] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55808.890070] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55808.897614] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.000079] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.007588] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.110035] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.117559] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.125363] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.220094] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.227789] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.330097] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.337638] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.440112] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.447645] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.550389] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon
[55809.557931] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 0, skipped old beacon
[55809.660388] ath10k_pci 0000:00:00.0: SWBA overrun on vdev 1, skipped old beacon

@openwrt-bot
Copy link
Author

psyborg:

same crash here with set_sta_sinfo message and few others. after interface recovered everything worked fine.

Linux version 4.14.118
MIPS: machine is Ubiquiti LiteBeam AC Gen2
ath79 target
STA xx:xx:xx:xx:xx:xx = AR9462 / Win10

Sun Sep 8 11:10:33 2019 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: authenticated
Sun Sep 8 11:10:36 2019 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: authenticated
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.509074] ath10k_pci 0000:00:00.0: failed to delete peer xx:xx:xx:xx:xx:xx for vdev 0: -145
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.517841] ath10k_pci 0000:00:00.0: found sta peer xx:xx:xx:xx:xx:xx (ptr 82def400 id 194) entry on vdev 0 after it was supposedly removed
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.530780] ------------[ cut here ]------------
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.535745] WARNING: CPU: 0 PID: 1447 at backports-4.19.32-1/net/mac80211/sta_info.c:1004 sta_set_sinfo+0xbac/0xc58 [mac80211]
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.547406] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw ath10k_pci ath10k_core ath pppox ppp_generic mac80211 iptable_nat iptable_mangle iptable_filter ipt_REJECT ipt_MASQUERADE ip_tables cfg80211 xt_time xt_tcpudp xt_state xt_nat xt_multiport xt_mark xt_mac xt_limit xt_conntrack xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_FLOWOFFLOAD x_tables thermal_sys slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_log_common nf_flow_table_hw nf_flow_table nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack hwmon crc_ccitt compat ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.607388] CPU: 0 PID: 1447 Comm: hostapd Not tainted 4.14.118 #0
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.613786] Stack : 804d0000 80489150 00000000 00000000 80460fc0 82dcfafc 82eab45c 804b1307
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.622387] 8045d190 000005a7 80603670 000003ec 82dcfcac 00000001 82dcfab0 0bb73a6e
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.630988] 00000000 00000000 80600000 00003ff8 00000000 00000000 00000008 00000000
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.639585] 000000cd 6827cfdb 000000cc 6d3a2068 80000000 00000000 83264c84 83207c1c
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.648168] 00000009 000003ec 82dcfcac 83add800 00000010 8026bd44 00000000 80600000
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.656763] ...
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.659347] Call Trace:
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.661949] [<8006a9ec>] show_stack+0x58/0x100
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.666578] [<80085080>] __warn+0xe4/0x118
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.670853] [<80085144>] warn_slowpath_null+0x1c/0x28
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.676220] [<83207c1c>] sta_set_sinfo+0xbac/0xc58 [mac80211]
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.682273] [<83207da8>] sta_info_destroy_addr_bss+0x38/0x60 [mac80211]
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.689265] [<8314f01c>] cfg80211_check_station_change+0x1be0/0x2c54 [cfg80211]
Sun Sep 8 11:10:39 2019 kern.warn kernel: [491454.696795] ---[ end trace 8cc47180b897e71e ]---
Sun Sep 8 11:10:42 2019 kern.warn kernel: [491457.709041] ath10k_pci 0000:00:00.0: failed to wait for created wmi peer xx:xx:xx:xx:xx:xx on vdev 0: -145
Sun Sep 8 11:10:42 2019 kern.warn kernel: [491457.718946] ath10k_pci 0000:00:00.0: failed to add peer xx:xx:xx:xx:xx:xx for vdev 0 when adding a new sta: -145
Sun Sep 8 11:10:42 2019 daemon.notice hostapd: wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: Could not add STA to kernel driver
Sun Sep 8 11:10:45 2019 kern.warn kernel: [491460.749027] ath10k_pci 0000:00:00.0: wmi command 36977 timeout, restarting hardware
Sun Sep 8 11:10:45 2019 kern.warn kernel: [491460.756905] ath10k_pci 0000:00:00.0: failed to send pdev bss chan info request
Sun Sep 8 11:10:45 2019 kern.info kernel: [491460.892000] ieee80211 phy0: Hardware restart was requested
Sun Sep 8 11:10:45 2019 kern.warn kernel: [491460.898798] ath10k_pci 0000:00:00.0: failed to set beacon mode for vdev 0: -143
Sun Sep 8 11:10:45 2019 kern.warn kernel: [491460.906410] ath10k_pci 0000:00:00.0: failed to set dtim period for vdev 0: -143
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.117200] ath10k_pci 0000:00:00.0: pdev param 0 not supported by firmware
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.149024] ------------[ cut here ]------------
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.154025] WARNING: CPU: 0 PID: 1408 at backports-4.19.32-1/net/mac80211/driver-ops.h:19 ieee80211_parse_p2p_noa+0x3ac/0xaa4 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.166585] wlan0.sta1: Failed check-sdata-in-driver check, flags: 0x1
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.173389] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw ath10k_pci ath10k_core ath pppox ppp_generic mac80211 iptable_nat iptable_mangle iptable_filter ipt_REJECT ipt_MASQUERADE ip_tables cfg80211 xt_time xt_tcpudp xt_state xt_nat xt_multiport xt_mark xt_mac xt_limit xt_conntrack xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_FLOWOFFLOAD x_tables thermal_sys slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_log_common nf_flow_table_hw nf_flow_table nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack hwmon crc_ccitt compat ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.233401] CPU: 0 PID: 1408 Comm: kworker/0:2 Tainted: G W 4.14.118 #0
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.241555] Workqueue: events_freezable ieee80211_alloc_hw_nm [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.248449] Stack : 00000009 00000013 832792f8 800b2b74 80460fc0 00000000 00000001 82e85894
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.257063] 8045d0fc 82fb5cdc 804b0000 800b39d4 832792f8 00000000 82fb5cb8 5fea3f86
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.265665] 00000000 00000000 00000000 00004c60 00000000 00000000 00000008 00000000
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.274263] 000000e9 804b0000 000000e8 65657a61 00000000 00000000 832662ac 83235c14
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.282856] 00000009 00000013 832792f8 00000000 00000000 8026bd44 00000000 80600000
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.291609] ...
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.294191] Call Trace:
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.296795] [<8006a9ec>] show_stack+0x58/0x100
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.301491] [<80085080>] __warn+0xe4/0x118
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.305747] [<800850e4>] warn_slowpath_fmt+0x30/0x3c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.311038] [<83235c14>] ieee80211_parse_p2p_noa+0x3ac/0xaa4 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.317906] [<803cc554>] __mutex_lock.isra.0+0x230/0x368
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.323490] [<832007e4>] ieee80211_alloc_hw_nm+0x784/0x7a4 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.330210] [<8009a0a4>] process_one_work+0x23c/0x3e8
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.335429] [<8009a570>] worker_thread+0x320/0x56c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.340414] [<8009f8a4>] kthread+0x128/0x13c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.344850] [<80065558>] ret_from_kernel_thread+0x14/0x1c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.350438] ---[ end trace 8cc47180b897e71f ]---
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.361001] ------------[ cut here ]------------
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.366043] WARNING: CPU: 0 PID: 1408 at backports-4.19.32-1/net/mac80211/key.c:741 ieee80211_enable_keys+0xb4/0x1a8 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.377828] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw ath10k_pci ath10k_core ath pppox ppp_generic mac80211 iptable_nat iptable_mangle iptable_filter ipt_REJECT ipt_MASQUERADE ip_tables cfg80211 xt_time xt_tcpudp xt_state xt_nat xt_multiport xt_mark xt_mac xt_limit xt_conntrack xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_FLOWOFFLOAD x_tables thermal_sys slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_log_common nf_flow_table_hw nf_flow_table nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack hwmon crc_ccitt compat ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.437888] CPU: 0 PID: 1408 Comm: kworker/0:2 Tainted: G W 4.14.118 #0
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.446028] Workqueue: events_freezable ieee80211_alloc_hw_nm [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.452936] Stack : 00000009 000002e5 00000005 800b2b74 80460fc0 00000000 00000001 82e85894
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.461538] 8045d0fc 82fb5ce4 804b0000 800b39d4 00000005 00000001 82fb5cc0 5fea3f86
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.470133] 00000000 00000000 804bda70 00005530 00000000 00000000 00000008 00000000
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.478716] 00000100 804b0000 000000ff 65657a61 00000000 00000000 83266130 83234a24
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.487311] 00000009 000002e5 00000005 00000000 00000000 8026bd44 00000000 80600000
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.496061] ...
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.498643] Call Trace:
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.501281] [<8006a9ec>] show_stack+0x58/0x100
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.505930] [<80085080>] __warn+0xe4/0x118
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.510210] [<80085144>] warn_slowpath_null+0x1c/0x28
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.515577] [<83234a24>] ieee80211_enable_keys+0xb4/0x1a8 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.522244] [<83238ad0>] ieee80211_reconfig+0x904/0xb88 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.528684] [<832007e4>] ieee80211_alloc_hw_nm+0x784/0x7a4 [mac80211]
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.535412] [<8009a0a4>] process_one_work+0x23c/0x3e8
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.540657] [<8009a570>] worker_thread+0x320/0x56c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.545617] [<8009f8a4>] kthread+0x128/0x13c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.550070] [<80065558>] ret_from_kernel_thread+0x14/0x1c
Sun Sep 8 11:10:47 2019 kern.warn kernel: [491462.555644] ---[ end trace 8cc47180b897e720 ]---
Sun Sep 8 11:10:47 2019 kern.info kernel: [491462.563426] ath10k_pci 0000:00:00.0: device successfully recovered

@openwrt-bot
Copy link
Author

adrianschmutzler:

Are you using ct or ct-htt? The latter is not the default.

Can you try again with a more recent version? CT driver has seen some fixes during the last year ...

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Projects
None yet
Development

No branches or pull requests

1 participant