Modify

Opened 2 years ago

Last modified 2 years ago

#20351 new defect

WRT1200AC intermittent cpu stall

Reported by: anonymous Owned by: developers
Priority: normal Milestone: Chaos Calmer 15.05
Component: other Version: Trunk
Keywords: Cc:

Description

Router: WRT1200ACv1

BusyBox v1.23.2 (2015-08-17 01:32:41 CEST) built-in shell (ash)

  _______                     ________        __
 |       |.-----.-----.-----.|  |  |  |.----.|  |_
 |   -   ||  _  |  -__|     ||  |  |  ||   _||   _|
 |_______||   __|_____|__|__||________||__|  |____|
          |__| W I R E L E S S   F R E E D O M
 -----------------------------------------------------
 CHAOS CALMER (Bleeding Edge, r46609)
 -----------------------------------------------------
  * 1 1/2 oz Gin            Shake with a glassful
  * 1/4 oz Triple Sec       of broken ice and pour
  * 3/4 oz Lime Juice       unstrained into a goblet.
  * 1 1/2 oz Orange Juice
  * 1 tsp. Grenadine Syrup
 -----------------------------------------------------

Linux router 3.18.20 #1 SMP Mon Aug 17 01:59:08 CEST 2015 armv7l GNU/Linux

dmesg

[   10.797327] ieee80211 phy0: 11 11 11 11 10 10 10 10 11 11 11 11 10 10 10 10
[   10.804395] ieee80211 phy0: Channel: 140: 0x0 0x0 0xf
[   10.809461] ieee80211 phy0: 11 11 11 11 10 10 10 10 11 11 11 11 10 10 10 10
[   10.816529] ieee80211 phy0: Channel: 149: 0x0 0x0 0xf
[   10.821598] ieee80211 phy0: 1a 1a 18 17 19 19 17 15 18 18 17 14 15 15 15 14
[   10.828662] ieee80211 phy0: Channel: 153: 0x0 0x0 0xf
[   10.833731] ieee80211 phy0: 1a 1a 18 17 1a 1a 17 15 1a 1a 17 14 15 15 15 14
[   10.840796] ieee80211 phy0: Channel: 157: 0x0 0x0 0xf
[   10.845865] ieee80211 phy0: 1a 1a 18 17 1a 1a 17 15 1a 1a 17 14 15 15 15 14
[   10.852933] ieee80211 phy0: Channel: 161: 0x0 0x0 0xf
[   10.857999] ieee80211 phy0: 1a 1a 18 17 1a 1a 17 15 1a 1a 17 14 15 15 15 14
[   10.865066] ieee80211 phy0: Channel: 165: 0x0 0x0 0xf
[   10.870132] ieee80211 phy0: 1a 1a 18 17 1a 1a 17 15 1a 1a 17 14 15 15 15 14
[   10.877953] pci 0000:00:02.0: enabling device (0140 -> 0142)
[   10.883722] ieee80211 phy1: priv->iobase0 = e1200000
[   10.888719] ieee80211 phy1: priv->iobase1 = e1400000
[   10.893753] ieee80211 phy1: priv->pcmd_buf = de2d0000  priv->pphys_cmd_buf = 1e2d0000
[   10.902838] ieee80211 phy1: fw download start 88
[   11.022751] ieee80211 phy1: FwSize = 116356 downloaded Size = 116356 curr_iteration 65510
[   11.285341] ieee80211 phy1: 0;
[   11.542783] ieee80211 phy1: 0;
[   11.800218] ieee80211 phy1: 0;
[   11.886079] ieee80211 phy1: complete
[   11.889678] ieee80211 phy1: 2G: enable
[   11.893438] ieee80211 phy1: 5G: disable
[   11.897282] ieee80211 phy1: TX: 2 antennas
[   11.901390] ieee80211 phy1: RX: 2 antennas
[   11.906780] ieee80211 phy1: pcmd = de2d0000
[   11.911783] ieee80211 phy1: mwl_fwcmd_set_hw_specs ...
[   11.916934] ieee80211 phy1:   -->pPhysTxRing[0] = 1e300000
[   11.922437] ieee80211 phy1:   -->pPhysTxRing[1] = 1e304000
[   11.927934] ieee80211 phy1:   -->pPhysTxRing[2] = 1e308000
[   11.933439] ieee80211 phy1:   -->pPhysTxRing[3] = 1e30c000
[   11.938936] ieee80211 phy1:   -->pPhysRxRing    = 1e998000
[   11.944438] ieee80211 phy1:   -->numtxq 20 wcbperq 256 totalrxwcb 256
[   11.955879] ieee80211 phy1: firmware version: 0x7020806
[   11.975173] ieee80211 phy1: phy1: FCC
[   11.978847] ieee80211 phy1: Channel: 1: 0x0 0x0 0xf
[   11.983748] ieee80211 phy1: 19 14 14 14 13 13 13 13 10 10 10 10 0 0 0 0
[   11.990464] ieee80211 phy1: Channel: 2: 0x0 0x0 0xf
[   11.995361] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.002080] ieee80211 phy1: Channel: 3: 0x0 0x0 0xf
[   12.006973] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.013694] ieee80211 phy1: Channel: 4: 0x0 0x0 0xf
[   12.018586] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.025305] ieee80211 phy1: Channel: 5: 0x0 0x0 0xf
[   12.030197] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.036920] ieee80211 phy1: Channel: 6: 0x0 0x0 0xf
[   12.041816] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.048533] ieee80211 phy1: Channel: 7: 0x0 0x0 0xf
[   12.053428] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.060146] ieee80211 phy1: Channel: 8: 0x0 0x0 0xf
[   12.065044] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.071764] ieee80211 phy1: Channel: 9: 0x0 0x0 0xf
[   12.076655] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.083374] ieee80211 phy1: Channel: 10: 0x0 0x0 0xf
[   12.088353] ieee80211 phy1: 1a 19 18 17 19 19 17 16 14 14 14 14 0 0 0 0
[   12.095072] ieee80211 phy1: Channel: 11: 0x0 0x0 0xf
[   12.100050] ieee80211 phy1: 19 15 15 15 14 14 14 14 13 13 13 13 0 0 0 0
[   12.108222] i2c /dev entries driver
[   12.117070] ip_tables: (C) 2000-2006 Netfilter Core Team
[   12.126369] nf_conntrack version 0.5.0 (8049 buckets, 32196 max)
[   12.245651] xt_time: kernel timezone is -0000
[   12.263285] PPP generic driver version 2.4.2
[   12.267984] NET: Registered protocol family 24
[   14.676289] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   14.684200] device eth0.1 entered promiscuous mode
[   14.689011] device eth0 entered promiscuous mode
[   14.695142] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
[   14.707312] IPv6: ADDRCONF(NETDEV_UP): eth0.1000: link is not ready
[   14.737181] IPv6: ADDRCONF(NETDEV_UP): eth0.2: link is not ready
[   15.511283] ieee80211 phy1: interface: 3, change: 0xe
[   15.546275] ieee80211 phy1: interface: 3, change: 0x2000
[   15.551605] ieee80211 phy1: change: 0xffffffff
[   15.627094] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
[   15.634112] device wlan1 entered promiscuous mode
[   15.638861] br-lan: port 2(wlan1) entered forwarding state
[   15.644385] br-lan: port 2(wlan1) entered forwarding state
[   15.650134] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[   15.688180] ieee80211 phy0: interface: 3, change: 0xe
[   15.723169] ieee80211 phy0: interface: 3, change: 0x2000
[   15.728495] ieee80211 phy0: change: 0xffffffff
[   15.804009] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   15.810036] br-lan: port 2(wlan1) entered disabled state
[   15.815476] ieee80211 phy1: change: 0x100
[   15.824494] ieee80211 phy1: change: 0x42
[   15.884260] ieee80211 phy1: interface: 3, change: 0x40000
[   15.889673] ieee80211 phy1: interface: 3, change: 0x4000
[   15.895024] ieee80211 phy1: interface: 3, change: 0xc8340
[   15.900443] ieee80211 phy1: wmm:26, rsn:0, rsn48:22, ht:62, vht:0
[   15.926609] br-lan: port 2(wlan1) entered forwarding state
[   15.932125] br-lan: port 2(wlan1) entered forwarding state
[   15.937659] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
[   15.944328] device wlan0 entered promiscuous mode
[   15.949097] ieee80211 phy1: interface: 3, change: 0x3e
[   15.979785] ieee80211 phy1: interface: 3, change: 0x2000
[   15.992372] ieee80211 phy1: interface: 3, change: 0x2000
[   16.009759] ieee80211 phy1: interface: 3, change: 0x2000
[   16.020114] ieee80211 phy1: interface: 3, change: 0x2000
[   16.086672] ieee80211 phy0: change: 0x100
[   16.095722] ieee80211 phy0: change: 0x42
[   16.155620] ieee80211 phy0: interface: 3, change: 0x40000
[   16.161054] ieee80211 phy0: interface: 3, change: 0x4000
[   16.166395] ieee80211 phy0: interface: 3, change: 0xc8340
[   16.171841] ieee80211 phy0: wmm:26, rsn:0, rsn48:22, ht:62, vht:21
[   16.198313] br-lan: port 3(wlan0) entered forwarding state
[   16.203842] br-lan: port 3(wlan0) entered forwarding state
[   16.209386] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   16.216919] ieee80211 phy0: interface: 3, change: 0x3e
[   16.247740] ieee80211 phy0: interface: 3, change: 0x2000
[   16.258114] ieee80211 phy0: interface: 3, change: 0x2000
[   16.268450] ieee80211 phy0: interface: 3, change: 0x2000
[   16.278782] ieee80211 phy0: interface: 3, change: 0x2000
[   16.800934] mvneta f1034000.ethernet eth0: link up
[   16.805942] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   16.812397] br-lan: port 1(eth0.1) entered forwarding state
[   16.818015] br-lan: port 1(eth0.1) entered forwarding state
[   16.823719] IPv6: ADDRCONF(NETDEV_CHANGE): eth0.2: link becomes ready
[   16.830322] IPv6: ADDRCONF(NETDEV_CHANGE): eth0.1000: link becomes ready
[   17.055080] ieee80211 phy1: interface: 3, change: 0x100
[   17.060336] ieee80211 phy1: wmm:26, rsn:0, rsn48:22, ht:62, vht:0
[   17.081727] ieee80211 phy1: interface: 3, change: 0x3e
[   17.930917] br-lan: port 2(wlan1) entered forwarding state
[   18.200914] br-lan: port 3(wlan0) entered forwarding state
[   18.810914] br-lan: port 1(eth0.1) entered forwarding state
[   19.849428] ieee80211 phy0: interface: 3, change: 0x100
[   19.854742] ieee80211 phy0: wmm:26, rsn:0, rsn48:22, ht:62, vht:21
[   19.876151] ieee80211 phy0: interface: 3, change: 0x36
[   20.452281] ieee80211 phy1: interface: 3, change: 0x100
[   20.457635] ieee80211 phy1: wmm:26, rsn:0, rsn48:22, ht:62, vht:0
[   20.479067] ieee80211 phy1: interface: 3, change: 0x3e
[  444.046792] u32 classifier
[  444.049526]     input device check on
[  444.053195]     Actions configured
[  444.060969] Mirror/redirect action on
[  444.194732] netem: version 1.3
[ 1199.413656] nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead.
[38374.256590] ieee80211 phy0: result error
[52224.027853] ieee80211 phy0: interface: 3, change: 0x100
[52224.033115] ieee80211 phy0: wmm:26, rsn:0, rsn48:22, ht:62, vht:21
[52224.054350] ieee80211 phy0: interface: 3, change: 0x36
[53149.052786] ieee80211 phy0: interface: 3, change: 0x100
[53149.058085] ieee80211 phy0: wmm:26, rsn:0, rsn48:22, ht:62, vht:21
[53149.079267] ieee80211 phy0: interface: 3, change: 0x36
[53424.032936] ieee80211 phy0: interface: 3, change: 0x100
[53424.038201] ieee80211 phy0: wmm:26, rsn:0, rsn48:22, ht:62, vht:21
[53424.059429] ieee80211 phy0: interface: 3, change: 0x36
[60421.951250] ieee80211 phy1: interface: 3, change: 0x100
[60421.956501] ieee80211 phy1: wmm:26, rsn:0, rsn48:22, ht:62, vht:0
[60421.977666] ieee80211 phy1: interface: 3, change: 0x3e
[60495.726290] ieee80211 phy1: interface: 3, change: 0x100
[60495.731561] ieee80211 phy1: wmm:26, rsn:0, rsn48:22, ht:62, vht:0
[60495.752739] ieee80211 phy1: interface: 3, change: 0x3e

logread

Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: EAPOL-Key timeout
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:20:35 2015 daemon.info hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: group key handshake completed (RSN)
Mon Aug 17 21:20:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key 2/2 Group with unexpected replay counter
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: WPA rekeying GTK
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: group key handshake completed (RSN)
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: group key handshake completed (RSN)
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: group key handshake completed (RSN)
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: group key handshake completed (RSN)
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: group key handshake completed (RSN)
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: group key handshake completed (RSN)
Mon Aug 17 21:30:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:30:35 2015 daemon.info hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: WPA rekeying GTK
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: EAPOL-Key timeout
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: EAPOL-Key timeout
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key 2/2 Group with unexpected replay counter
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:40:35 2015 daemon.info hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: group key handshake completed (RSN)
Mon Aug 17 21:40:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key 2/2 Group with unexpected replay counter
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: WPA rekeying GTK
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:35 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:35 2015 daemon.info hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:35 2015 daemon.info hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:35 2015 daemon.info hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:35 2015 daemon.info hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:35 2015 daemon.info hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: EAPOL-Key timeout
Mon Aug 17 21:50:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:36 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: EAPOL-Key timeout
Mon Aug 17 21:50:36 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 21:50:36 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 21:50:36 2015 daemon.info hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: group key handshake completed (RSN)
Mon Aug 17 21:50:37 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key 2/2 Group with unexpected replay counter
Mon Aug 17 21:50:37 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key 2/2 Group with unexpected replay counter
Mon Aug 17 21:53:32 2015 authpriv.info dropbear[21649]: Child connection from 192.168.127.65:1709
Mon Aug 17 21:53:35 2015 authpriv.notice dropbear[21649]: Password auth succeeded for 'root' from 192.168.127.65:1709
Mon Aug 17 21:56:28 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: event 2 notification
Mon Aug 17 21:56:28 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.1X: unauthorizing port
Mon Aug 17 21:56:28 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.11: disassociated
Mon Aug 17 21:56:28 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-DISASSOCIATE.indication(b8:f6:b1:12:f3:8b, 8)
Mon Aug 17 21:56:28 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-DELETEKEYS.request(b8:f6:b1:12:f3:8b)
Mon Aug 17 21:56:29 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.11: deauthenticated due to inactivity (timer DEAUTH/REMOVE)
Mon Aug 17 21:56:29 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-DEAUTHENTICATE.indication(b8:f6:b1:12:f3:8b, 2)
Mon Aug 17 21:56:29 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-DELETEKEYS.request(b8:f6:b1:12:f3:8b)
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: WPA rekeying GTK
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: sending 1/2 msg of Group Key Handshake
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 22:00:35 2015 daemon.info hostapd: wlan1: STA 24:0a:64:04:6e:e7 WPA: group key handshake completed (RSN)
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 22:00:35 2015 daemon.info hostapd: wlan1: STA 6c:ad:f8:84:74:27 WPA: group key handshake completed (RSN)
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 22:00:35 2015 daemon.info hostapd: wlan1: STA f4:81:39:96:64:d5 WPA: group key handshake completed (RSN)
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 22:00:35 2015 daemon.info hostapd: wlan1: STA 00:03:2a:1c:84:b9 WPA: group key handshake completed (RSN)
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 22:00:35 2015 daemon.info hostapd: wlan1: STA a0:02:dc:cc:85:c3 WPA: group key handshake completed (RSN)
Mon Aug 17 22:00:35 2015 daemon.debug hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: received EAPOL-Key frame (2/2 Group)
Mon Aug 17 22:00:35 2015 daemon.info hostapd: wlan1: STA f4:09:d8:92:92:10 WPA: group key handshake completed (RSN)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.11: authentication OK (open system)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-AUTHENTICATE.indication(b8:f6:b1:12:f3:8b, OPEN_SYSTEM)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-DELETEKEYS.request(b8:f6:b1:12:f3:8b)
Mon Aug 17 22:05:50 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.11: authenticated
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.11: association OK (aid 7)
Mon Aug 17 22:05:50 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.11: associated (aid 7)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-ASSOCIATE.indication(b8:f6:b1:12:f3:8b)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b MLME: MLME-DELETEKEYS.request(b8:f6:b1:12:f3:8b)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: event 1 notification
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: start authentication
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.1X: unauthorizing port
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: sending 1/4 msg of 4-Way Handshake
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: received EAPOL-Key frame (2/4 Pairwise)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: sending 3/4 msg of 4-Way Handshake
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: EAPOL-Key timeout
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: sending 3/4 msg of 4-Way Handshake
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: received EAPOL-Key frame (4/4 Pairwise)
Mon Aug 17 22:05:50 2015 daemon.debug hostapd: wlan1: STA b8:f6:b1:12:f3:8b IEEE 802.1X: authorizing port
Mon Aug 17 22:05:50 2015 daemon.info hostapd: wlan1: STA b8:f6:b1:12:f3:8b WPA: pairwise key handshake completed (RSN)
Mon Aug 17 22:05:52 2015 daemon.info dnsmasq-dhcp[20763]: DHCPREQUEST(br-lan) 192.168.127.57 b8:f6:b1:12:f3:8b
Mon Aug 17 22:05:52 2015 daemon.info dnsmasq-dhcp[20763]: DHCPACK(br-lan) 192.168.127.57 b8:f6:b1:12:f3:8b Yosemite-MBP

For the most part router runs great on fresh reboot.
CPU stays near 0% usage and performance is great.
But after some time (I am still unsure of the trigger, I am guessing it is related to "[38374.256590] ieee80211 phy0: result error" but this message doesn't always trigger the stalls, my suspected cause of trouble is my wife's MacBookPro or Samsung Galaxy Alpha), router begins to stall randomly for few seconds. This significantly slows down Luci (partial page display and hangs for few seconds before displaying the rest) or even SSH (I have to wait for SSH to respond after every few keystrokes).

-Internet occasionally drops for few seconds continues to work at degraded state (with higher than normal bufferbloat and spikes during the stalls of course) but never completely hangs.
-I have tried putting radios on different CPUs, but it didn't fix the issue
-Issues existed when I ran CC RC3 with new wifi firmware.

Are there any diagnostics I can provide to help track down the cause of this condition?

Attachments (0)

Change History (2)

comment:2 Changed 2 years ago by anonymous

Issue still exists in current trunk but testing with new driver indicates that CPU stalls are related to how the drivers handle irqs. Please close this ticket.

Add Comment

Modify Ticket

Action
as new .
Author


E-mail address and user name can be saved in the Preferences.

 
Note: See TracTickets for help on using tickets.