OpenWrt/LEDE Project

  • Status New
  • Percent Complete
    0%
  • Task Type Bug Report
  • Category Kernel
  • Assigned To No-one
  • Operating System All
  • Severity Low
  • Priority Low
  • Reported Version lede-17.01
  • Due in Version Undecided
  • Due Date Undecided
  • Votes 3
  • Private
Attached to Project: OpenWrt/LEDE Project
Opened by Baptiste Jonglez - 25.02.2017

FS#555 - mac80211/ath9k warning: Rate marked as an HT rate but passed status->rate_idx is not an MCS index

I have been using LEDE 17.01 on a WR841N v8, with a simple 2.4 GHz AP (’mixed-psk’ security).

Recently I have seen this kernel warning in the logs: it might be nothing or it might be something important, who knows.

Feb 23 17:23:59 AP4 kernel: [62871.843902] ------------[ cut here ]------------
Feb 23 17:23:59 AP4 kernel: [62871.848752] WARNING: CPU: 0 PID: 0 at compat-wireless-2016-10-08/net/mac80211/rx.c:4180 0x80e2529c [mac80211@80e00000+0x5f500]()
Feb 23 17:23:59 AP4 kernel: [62871.860717] Rate marked as an HT rate but passed status->rate_idx is not an MCS index [0-76]: 113 (0x71)
Feb 23 17:23:59 AP4 kernel: [62871.870518] Modules linked in: ath9k ath9k_common pppoe ppp_async iptable_nat ath9k_hw ath pppox ppp_generic nf_nat_ipv4 nf_conntrack_ipv6 nf_conntrack_ipv4 mac80211 ipt_REJECT ipt_MASQUERADE 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_CT slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_nat nf_log_ipv4 nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack ipta
Feb 23 17:23:59 AP4 kernel: [62871.930136] CPU: 0 PID: 0 Comm: swapper Not tainted 4.4.50 #0
Feb 23 17:23:59 AP4 kernel: [62871.936073] Stack : 80386534 00000000 00000001 803e0000 00000000 00000000 00000000 00000000
Feb 23 17:23:59 AP4 kernel: [62871.936073] #011  00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Feb 23 17:23:59 AP4 kernel: [62871.936073] #011  00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Feb 23 17:23:59 AP4 kernel: [62871.936073] #011  00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Feb 23 17:23:59 AP4 kernel: [62871.936073] #011  00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Feb 23 17:23:59 AP4 kernel: [62871.936073] #011  ...
Feb 23 17:23:59 AP4 kernel: [62871.973122] Call Trace:[<80071a50>] 0x80071a50
Feb 23 17:23:59 AP4 kernel: [62871.977762] [<80071a50>] 0x80071a50
Feb 23 17:23:59 AP4 kernel: [62871.981372] [<800817e8>] 0x800817e8
Feb 23 17:23:59 AP4 kernel: [62871.984987] [<80e2529c>] 0x80e2529c [mac80211@80e00000+0x5f500]
Feb 23 17:23:59 AP4 kernel: [62871.991120] [<80081844>] 0x80081844
Feb 23 17:23:59 AP4 kernel: [62871.994729] [<802a385c>] 0x802a385c
Feb 23 17:23:59 AP4 kernel: [62871.998352] [<80e2529c>] 0x80e2529c [mac80211@80e00000+0x5f500]
Feb 23 17:23:59 AP4 kernel: [62872.004468] [<8025fea8>] 0x8025fea8
Feb 23 17:23:59 AP4 kernel: [62872.008086] [<8026008c>] 0x8026008c
Feb 23 17:23:59 AP4 kernel: [62872.011694] [<80d08388>] 0x80d08388 [ath9k_common@80d08000+0x47e0]
Feb 23 17:23:59 AP4 kernel: [62872.018112] [<81ba77dc>] 0x81ba77dc [ath9k@81ba0000+0x16650]
Feb 23 17:23:59 AP4 kernel: [62872.023975] [<81ba77bc>] 0x81ba77bc [ath9k@81ba0000+0x16650]
Feb 23 17:23:59 AP4 kernel: [62872.029854] [<81ba4a44>] 0x81ba4a44 [ath9k@81ba0000+0x16650]
Feb 23 17:23:59 AP4 kernel: [62872.035704] [<800843a8>] 0x800843a8
Feb 23 17:23:59 AP4 kernel: [62872.039327] [<80083d64>] 0x80083d64
Feb 23 17:23:59 AP4 kernel: [62872.042937] [<800a7e08>] 0x800a7e08
Feb 23 17:23:59 AP4 kernel: [62872.046547] [<8006a950>] 0x8006a950
Feb 23 17:23:59 AP4 kernel: [62872.050169] [<80060bf4>] 0x80060bf4
Feb 23 17:23:59 AP4 kernel: [62872.053769] 
Feb 23 17:23:59 AP4 kernel: [62872.055314] ---[ end trace 90699e3e72694b86 ]---
Feb 23 17:24:02 AP4 kernel: [62875.131392] ath: phy0: DMA failed to stop in 10 ms AR_CR=0x00000024 AR_DIAG_SW=0x02100020 DMADBG_7=0x00024300


Snotto commented on 05.03.2017 10:35

Got the same issue ... could be the reason why my memory of my 1043 freaks out and i cant use luci and other programs anymore after this is happen

Snotto commented on 28.03.2017 18:11

i checked it and it is like i said ... after this issue the luci interface is not more useable until you reboot the router

aversario commented on 30.05.2017 18:30

Same here, I am using psk2+ccmp encryption, the router is Mikrotik RB411AH, LEDE version → LEDE Reboot SNAPSHOT r3968-e20965811d / LuCI Master (git-17.103.24187-a82ca22)

Clients are still reachable and I can still use Luci:

[243331.960634] ————[ cut here ]———— [243331.965543] WARNING: CPU: 0 PID: 0 at compat-wireless-2017-01-31/net/mac80211/rx.c:4214 ieee80211_rx_napi+0x130/0x8b0 [mac80211]()
[243331.977400] Rate marked as an HT rate but passed status→rate_idx is not an MCS index [0-76]: 96 (0x60)
[243331.986865] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw 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_TCPMSS xt_REDIRECT xt_LOG xt_HL xt_DSCP 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_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache iptable_mangle iptable_filter ipt_ECN ip_tables crc_ccitt compat sch_cake nf_conntrack act_skbedit act_mirred em_u32 cls_u32 cls_tcindex cls_flow cls_route cls_fw sch_tbf sch_htb sch_hfsc sch_ingress xt_set ip_set_list_set ip_set_hash_netiface ip_set_hash_netport 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 ifb gpio_button_hotplug
[243332.094614] CPU: 0 PID: 0 Comm: swapper Not tainted 4.4.59 #0
[243332.100443] Stack : 8042271c 00000000 00000001 80480000 804710dc 80470d63 803fa3bc 00000000
[243332.100443] 804d3784 82c1b5e4 00000000 0000005c 00000000 800a73b4 803ff960 80470000
[243332.100443] 00000003 82c1b5e4 803fdd60 83809d5c 00000000 800a5330 00000002 00000000
[243332.100443] 00000000 8022ed00 00000000 00000000 00000000 00000000 00000000 00000000
[243332.100443] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[243332.100443] ...
[243332.136315] Call Trace:
[243332.138866] [<800a73b4>] vprintk_default+0x24/0x30
[243332.143757] [<800a5330>] printk+0x2c/0x38
[243332.147876] [<8022ed00>] wait_for_xmitr+0x18/0xcc
[243332.152684] [<800819c0>] warn_slowpath_common+0xa0/0xd0
[243332.158005] [<801dba00>] dump_stack+0x14/0x28
[243332.162460] [<80071c10>] show_stack+0x50/0x84
[243332.166919] [<800819c0>] warn_slowpath_common+0xa0/0xd0
[243332.172330] [<832a5cf0>] ieee80211_rx_napi+0x130/0x8b0 [mac80211]
[243332.178547] [<80081a1c>] warn_slowpath_fmt+0x2c/0x38
[243332.183683] [<832a5cf0>] ieee80211_rx_napi+0x130/0x8b0 [mac80211]
[243332.189869] [<802aea98>] build_skb+0x48/0xc8
[243332.194409] [<802f3de8>] ip_finish_output+0x0/0x24c
[243332.199503] [<8328490c>] ieee80211_find_sta_by_ifaddr+0x14/0x8c [mac80211]
[243332.206530] [<833683a4>] ath_rx_tasklet+0xee8/0xf4c [ath9k]
[243332.212186] [<802efb84>] ip_rcv+0x2c8/0x334
[243332.216501] [<83368370>] ath_rx_tasklet+0xeb4/0xf4c [ath9k]
[243332.222178] [<83365228>] ath9k_tasklet+0x200/0x28c [ath9k]
[243332.227762] [<80084580>] tasklet_action+0x80/0xc8
[243332.232548] [<80083f3c>]
do_softirq+0x250/0x298
[243332.237356] [<800a800c>] generic_handle_irq+0x24/0x3c
[243332.242499] [<8006a940>] plat_irq_dispatch+0xd4/0x10c
[243332.247648] [<80060bf4>] handle_int+0x134/0x140
[243332.252256]
[243332.253836] —[ end trace ccad4bcf4e237030 ]— [243332.258698] ————[ cut here ]———— [243332.263532] WARNING: CPU: 0 PID: 0 at compat-wireless-2017-01-31/net/mac80211/rx.c:4214 ieee80211_rx_napi+0x130/0x8b0 [mac80211]()
[243332.275354] Rate marked as an HT rate but passed status→rate_idx is not an MCS index [0-76]: 96 (0x60)
[243332.284813] Modules linked in: ath9k ath9k_common pppoe ppp_async ath9k_hw 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_TCPMSS xt_REDIRECT xt_LOG xt_HL xt_DSCP 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_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache iptable_mangle iptable_filter ipt_ECN ip_tables crc_ccitt compat sch_cake nf_conntrack act_skbedit act_mirred em_u32 cls_u32 cls_tcindex cls_flow cls_route cls_fw sch_tbf sch_htb sch_hfsc sch_ingress xt_set ip_set_list_set ip_set_hash_netiface ip_set_hash_netport 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 ifb gpio_button_hotplug
[243332.392556] CPU: 0 PID: 0 Comm: swapper Tainted: G W 4.4.59 #0
[243332.399603] Stack : 8042271c 00000000 00000001 80480000 804710dc 80470d63 803fa3bc 00000000
[243332.399603] 804d3784 82c1b5e4 00000000 0000005c 00000000 800a73b4 803ff960 80470000
[243332.399603] 00000003 82c1b5e4 803fdd60 83809d5c 00000000 800a5330 00000002 00000000
[243332.399603] 8046fe90 8022ed00 00000000 00000000 00000000 00000000 00000000 00000000
[243332.399603] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[243332.399603] ...
[243332.435460] Call Trace:
[243332.438018] [<800a73b4>] vprintk_default+0x24/0x30
[243332.442910] [<800a5330>] printk+0x2c/0x38
[243332.447026] [<8022ed00>] wait_for_xmitr+0x18/0xcc
[243332.451837] [<800819c0>] warn_slowpath_common+0xa0/0xd0
[243332.457159] [<801dba00>] dump_stack+0x14/0x28
[243332.461613] [<80071c10>] show_stack+0x50/0x84
[243332.466072] [<800819c0>] warn_slowpath_common+0xa0/0xd0
[243332.471496] [<832a5cf0>] ieee80211_rx_napi+0x130/0x8b0 [mac80211]
[243332.477730] [<80081a1c>] warn_slowpath_fmt+0x2c/0x38
[243332.482873] [<832a5cf0>] ieee80211_rx_napi+0x130/0x8b0 [mac80211]
[243332.489058] [<802aea98>] build_skb+0x48/0xc8
[243332.493598] [<802f3de8>] ip_finish_output+0x0/0x24c
[243332.498691] [<8328490c>] ieee80211_find_sta_by_ifaddr+0x14/0x8c [mac80211]
[243332.505711] [<833683a4>] ath_rx_tasklet+0xee8/0xf4c [ath9k]
[243332.511388] [<802efb84>] ip_rcv+0x2c8/0x334
[243332.515694] [<83368370>] ath_rx_tasklet+0xeb4/0xf4c [ath9k]
[243332.521391] [<83365228>] ath9k_tasklet+0x200/0x28c [ath9k]
[243332.526972] [<80084580>] tasklet_action+0x80/0xc8
[243332.531753] [<80083f3c>]
do_softirq+0x250/0x298
[243332.536561] [<800a800c>] generic_handle_irq+0x24/0x3c
[243332.541704] [<8006a940>] plat_irq_dispatch+0xd4/0x10c
[243332.546849] [<80060bf4>] handle_int+0x134/0x140
[243332.551453]
[243332.553033] —[ end trace ccad4bcf4e237031 ]— [328904.317515] ath: phy0: DMA failed to stop in 10 ms AR_CR=0x00000024 AR_DIAG_SW=0x42100020 DMADBG_7=0x000084c0
[437029.865524] ath: phy0: DMA failed to stop in 10 ms AR_CR=0x00000024 AR_DIAG_SW=0x42100020 DMADBG_7=0x000084c0

komar commented on 18.10.2017 10:15

Same on Ubiquti Bullet M2, Reboot (17.01-SNAPSHOT, r3535+34-ee32de4426).

I can reproduce bug, if someone can help with patching.

[16300.581775] ------------[ cut here ]------------
[16300.586722] WARNING: CPU: 0 PID: 3 at compat-wireless-2017-01-31/net/mac80211/rx.c:4214 ieee80211_rx_napi+0x130/0x8b0 [mac80211]()
[16300.598526] Rate marked as an HT rate but passed status->rate_idx is not an MCS index [0-76]: 95 (0x5f)
[16300.607957] Modules linked in: iptable_nat ath9k nf_nat_ipv4 nf_conntrack_ipv6 nf_conntrack_ipv4 ipt_REJECT ipt_MASQUERADE ebtable_nat ebtable_filter ebtable_broute ath9k_common xt_time xt
_tcpudp xt_tcpmss xt_statistic xt_state xt_nat xt_multiport xt_mark xt_mac xt_limit xt_length xt_hl xt_ecn xt_dscp xt_conntrack xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_HL xt_DSCP xt_CT xt_
CLASSIFY nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_nat nf_log_ipv4 nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack mac80211 iptable_mangle iptable_filter ipt_EC
N ip_tables ebtables ebt_vlan ebt_stp ebt_snat ebt_redirect ebt_pkttype ebt_mark_m ebt_mark ebt_limit ebt_ip6 ebt_ip ebt_dnat ebt_arpreply ebt_arp ebt_among ebt_802_3 br_netfilter ath9k_hw at
h batman_adv libcrc32c cfg80211 compat xt_set ip_set_list_set ip_set_hash_netiface ip_set_hash_netport ip_set_hash_netnet ip_set_hash_net ip_set_hash_netportnet ip_set_hash_mac ip_set_hash_ip
portnet 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_ip
v6 nf_log_common ip6table_mangle ip6table_filter ip6_tables x_tables dummy veth ohci_platform ohci_hcd ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common crc16 crc32c_gene
ric crypto_hash
[16300.726849] CPU: 0 PID: 3 Comm: ksoftirqd/0 Not tainted 4.4.89 #0
[16300.732958] Stack : 803e3444 00000000 00000001 80440000 8182cc94 8042ce63 803c4a38 00000003
[16300.732958]    804a378c 0000009b 00000000 8074e0d8 00000000 800a7844 803ca150 80430000
[16300.732958]    00000003 0000009b 803c855c 8183fc24 00000000 800a57c0 00000002 00000000
[16300.732958]    00000000 801f5a00 00000000 00000000 00000000 00000000 00000000 00000000
[16300.732958]    00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[16300.732958]    ...
[16300.768915] Call Trace:
[16300.771394] [<80071ee4>] show_stack+0x54/0x88
[16300.775802] [<80081ce4>] warn_slowpath_common+0xa0/0xd0
[16300.781058] [<80081d40>] warn_slowpath_fmt+0x2c/0x38
[16300.786211] [<80ea5cf0>] ieee80211_rx_napi+0x130/0x8b0 [mac80211]
[16300.792437] [<80de8374>] ath_rx_tasklet+0xee8/0xf4c [ath9k]
[16300.798085] [<80de51b8>] ath9k_tasklet+0x200/0x28c [ath9k]
[16300.803623] [<800848a4>] tasklet_action+0x80/0xc8
[16300.808368] [<80084260>] __do_softirq+0x250/0x298
[16300.813099] [<800842d0>] run_ksoftirqd+0x28/0x60
[16300.817766] [<8009ae90>] smpboot_thread_fn+0x158/0x188
[16300.822932] [<800988c0>] kthread+0xd8/0xec
[16300.827069] [<80060878>] ret_from_kernel_thread+0x14/0x1c
[16300.832483]
[16300.833983] ---[ end trace 1bfefb9139f1b391 ]---

Loading...

Available keyboard shortcuts

Tasklist

Task Details

Task Editing