#20854: ath10k "failed to delete peer" kernel errors causing wireless failure
---------------------------+------------------------
Reporter: hancockrwd@… | Owner: developers
Type: defect | Status: closed
Priority: normal | Milestone:
Component: kernel | Version: Trunk
Resolution: fixed | Keywords:
---------------------------+------------------------
Comment (by gkelleter):
I have to reopen this ticket because it is really far from resolved.
This bug happens on current OpenWrt master branch with different
firmwares. (as of May 2016)
10.2.4.70-2
10.2.4.70.12-2
10.2.4.70.31-1
10.2.4.70.42-2
10.2.4.97-1
It always happens shortly after a GTK rekey.
The only difference between the firmwares is that it appears to happen
sooner (after first GTK rekey, i.e 10min) or later (after 1 to 2 hours)
After these events the ath10k radio is dead. Must restart wifi to make it
work again for the next 10 minutes), rinse and repeat.
{{{
root@devolo-004:/# [ 3790.240000] ath10k_pci 0000:00:00.0: failed to
delete peer 78:7e:61:61:15:a3 for vdev 0: -145
[ 3790.240000] ------------[ cut here ]------------
[ 3790.250000] WARNING: CPU: 0 PID: 1663 at
/home/gke/build.openwrt/openwrt/1200ac/build_dir/target-
mips_34kc_uClibc-0.9.33.2/linux-ar71xx_g
eneric/compat-wireless-2016-01-10/net/mac80211/sta_info.c:933
sta_set_sinfo+0xa64/0xaf4 [mac80211]()
[ 3790.270000] Modules linked in: iptable_nat ath9k nf_nat_ipv4
nf_conntrack_ipv6 nf_conntrack_ipv4 ipt_REJECT ipt_MASQUERADE ath9k_common
x
t_time xt_tcpudp xt_state xt_nat xt_multiport xt_mark xt_mac xt_limit
xt_id xt_conntrack xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_CT nf_re
ject_ipv4 nf_nat_masquerade_ipv4 nf_nat_ftp nf_nat nf_log_ipv4
nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack_ftp
nf_conntr
ack iptable_raw iptable_mangle iptable_filter ip_tables ath9k_hw
ath10k_pci ath10k_core ath mac80211 cfg80211 compat ledtrig_oneshot
ip6t_RE
JECT nf_reject_ipv6 nf_log_ipv6 nf_log_common ip6table_raw ip6table_mangle
ip6table_filter ip6_tables x_tables dummy tun ipv6 arc4 crypto_bl
kcipher gpio_button_hotplug
[ 3790.330000] CPU: 0 PID: 1663 Comm: hostapd Not tainted 3.18.29 #96
[ 3790.340000] Stack : 00000000 00000000 00000000 00000000 80424372
00000036 00000000 872081a8
00000001 00000000 8033ac2c 803ac083 0000067f 804235b0 87a210e8
00000000
00000004 00000000 00000008 800a6a50 00000003 80081340 000003a5
00000000
80340114 8699b76c 00000000 00000000 00000000 00000000 00000000
00000000
00000000 00000000 00000000 00000000 00000000 00000000 00000000
00000000
...
[ 3790.380000] Call Trace:
[ 3790.380000] [<80071a40>] show_stack+0x50/0x84
[ 3790.380000] [<80081454>] warn_slowpath_common+0x88/0xb8
[ 3790.390000] [<8008150c>] warn_slowpath_null+0x18/0x24
[ 3790.390000] [<872081a8>] sta_set_sinfo+0xa64/0xaf4 [mac80211]
[ 3790.400000]
[ 3790.400000] ---[ end trace 3941d637727a1e7c ]---
[ 3793.420000] ath10k_pci 0000:00:00.0: failed to set dtim period for vdev
0: -11
[ 3796.420000] ath10k_pci 0000:00:00.0: failed to recalculate rts/cts prot
for vdev 0: -11
[ 3799.420000] ath10k_pci 0000:00:00.0: failed to set protection mode 0 on
vdev 0: -11
[ 3802.420000] ath10k_pci 0000:00:00.0: failed to set preamble for vdev 0:
-11
[ 4233.340000] ath10k_pci 0000:00:00.0: failed to install key for vdev 0
peer 74:da:38:1c:90:9d: -11
[ 4233.340000] wlan0: failed to remove key (2, ff:ff:ff:ff:ff:ff) from
hardware (-11)
[ 4236.350000] ath10k_pci 0000:00:00.0: failed to install key for vdev 0
peer 74:da:38:1c:90:9d: -11
[ 4236.350000] wlan0: failed to set key (2, ff:ff:ff:ff:ff:ff) to hardware
(-11)
}}}
after wifi restart:
{{{
Wed May 18 09:46:39 2016 daemon.info hostapd: wlan0: STA 78:7e:61:61:15:a3
IEEE 802.1X: authenticated - EAP type: 25 (PEAP)
Wed May 18 09:46:39 2016 daemon.debug hostapd: wlan0: RADIUS Received 20
bytes from RADIUS server
Wed May 18 09:46:39 2016 daemon.debug hostapd: wlan0: RADIUS Received
RADIUS message
Wed May 18 09:46:39 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 RADIUS: Received RADIUS packet matched with a pending
request, round trip time 0.00 sec
Wed May 18 09:48:48 2016 daemon.notice netifd: lan (1137): Sending
renew...
Wed May 18 09:48:48 2016 daemon.notice netifd: lan (1137): Lease of
172.25.200.242 obtained, lease time 600
Wed May 18 09:51:39 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 RADIUS: updated TX/RX stats: Acct-Input-Octets=5367
Acct-Input-G
igawords=0 Acct-Output-Octets=5223 Acct-Output-Gigawords=0
Wed May 18 09:53:49 2016 daemon.notice netifd: lan (1137): Sending
renew...
Wed May 18 09:53:49 2016 daemon.notice netifd: lan (1137): Lease of
172.25.200.242 obtained, lease time 600
Wed May 18 09:53:54 2016 daemon.debug hostapd: wlan0: WPA rekeying GTK
Wed May 18 09:53:54 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: sending 1/2 msg of Group Key Handshake
Wed May 18 09:53:55 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: EAPOL-Key timeout
Wed May 18 09:53:55 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: sending 1/2 msg of Group Key Handshake
Wed May 18 09:53:56 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: EAPOL-Key timeout
Wed May 18 09:53:56 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: sending 1/2 msg of Group Key Handshake
Wed May 18 09:53:57 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: EAPOL-Key timeout
Wed May 18 09:53:57 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: sending 1/2 msg of Group Key Handshake
Wed May 18 09:53:58 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: EAPOL-Key timeout
Wed May 18 09:53:58 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: WPA_PTK: sm->Disconnect
Wed May 18 09:53:58 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 WPA: event 3 notification
[63362.540000] ath10k_pci 0000:00:00.0: failed to delete peer
78:7e:61:61:15:a3 for vdev 0: -145
Wed May 18 09:54:03 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 MLME: MLME-DEAUTHENTICATE.indication(78:7e:61:61:15:a3,
2)
Wed May 18 09:54:03 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 MLME: MLME-DELETEKEYS.request(78:7e:61:61:15:a3)
Wed May 18 09:54:03 2016 daemon.info hostapd: wlan0: STA 78:7e:61:61:15:a3
IEEE 802.11: deauthenticated due to local deauth request
Wed May 18 09:54:03 2016 kern.warn kernel: [63362.540000] ath10k_pci
0000:00:00.0: failed to delete peer 78:7e:61:61:15:a3 for vdev 0: -145
Wed May 18 09:54:03 2016 daemon.debug hostapd: wlan0: RADIUS Sending
RADIUS message to accounting server
Wed May 18 09:54:03 2016 daemon.debug hostapd: wlan0: RADIUS Next RADIUS
client retransmit in 3 seconds
Wed May 18 09:54:03 2016 daemon.info hostapd: wlan0: STA 78:7e:61:61:15:a3
RADIUS: stopped accounting session 573C1D3A-00000000
[63365.550000] ath10k_pci 0000:00:00.0: failed to set dtim period for vdev
0: -11
Wed May 18 09:54:06 2016 kern.warn kernel: [63365.550000] ath10k_pci
0000:00:00.0: failed to set dtim period for vdev 0: -11
[63368.550000] ath10k_pci 0000:00:00.0: failed to recalculate rts/cts prot
for vdev 0: -11
Wed May 18 09:54:09 2016 kern.warn kernel: [63368.550000] ath10k_pci
0000:00:00.0: failed to recalculate rts/cts prot for vdev 0: -11
[63371.550000] ath10k_pci 0000:00:00.0: failed to set protection mode 0 on
vdev 0: -11
Wed May 18 09:54:12 2016 kern.warn kernel: [63371.550000] ath10k_pci
0000:00:00.0: failed to set protection mode 0 on vdev 0: -11
[63374.550000] ath10k_pci 0000:00:00.0: failed to set preamble for vdev 0:
-11
Wed May 18 09:54:15 2016 daemon.debug hostapd: wlan0: RADIUS Received 20
bytes from RADIUS server
Wed May 18 09:54:15 2016 daemon.debug hostapd: wlan0: RADIUS Received
RADIUS message
Wed May 18 09:54:15 2016 daemon.debug hostapd: wlan0: STA
78:7e:61:61:15:a3 RADIUS: Received RADIUS packet matched with a pending
request, r
ound trip time 12.00 sec
Wed May 18 09:54:15 2016 kern.warn kernel: [63374.550000] ath10k_pci
0000:00:00.0: failed to set preamble for vdev 0: -11
}}}
--
Ticket URL: <https://dev.openwrt.org/ticket/20854#comment:19>
OpenWrt <http://openwrt.org>
Opensource Wireless Router Technology
_______________________________________________
openwrt-tickets mailing list
openwrt-tickets@lists.openwrt.org
https://lists.openwrt.org/cgi-bin/mailman/listinfo/openwrt-tickets
