Skip site navigation (1)Skip section navigation (2)
Date:      Sun, 27 Jan 2013 12:31:34 +0000
From:      Vincent Hoffman <vince@unsane.co.uk>
To:        "freebsd-wireless@freebsd.org" <freebsd-wireless@freebsd.org>
Subject:   wireless link flaps (ath ar9280)
Message-ID:  <51051E26.1050300@unsane.co.uk>

next in thread | raw e-mail | index | archive | help
Hi all,
        I'm running a recent -current (r245741) and seem to be getting
interface flaps. Since this machine is mainly used for home mail and a
little light file serving I'm not sure when they started occuring as i
only have logging going back to the 18th Jan.

Sample log messages are:
Jan 24 16:26:22 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 24 16:26:22 ostracod kernel: AR_CR=0x00000024
Jan 24 16:26:22 ostracod kernel: AR_DIAG_SW=0x42000020
Jan 24 16:26:23 ostracod wpa_supplicant[568]: CTRL-EVENT-DISCONNECTED
bssid=e0:91:f5:48:5b:b9 reason=0
Jan 24 16:26:23 ostracod kernel: wlan0: link state changed to DOWN
Jan 24 16:26:26 ostracod wpa_supplicant[568]: Trying to associate with
e0:91:f5:48:5b:b9 (SSID='vhoff' freq=2462 MHz)
Jan 24 16:26:26 ostracod wpa_supplicant[568]: Associated with
e0:91:f5:48:5b:b9
Jan 24 16:26:26 ostracod kernel: wlan0: link state changed to UP
Jan 24 16:26:27 ostracod wpa_supplicant[568]: WPA: Key negotiation
completed with e0:91:f5:48:5b:b9 [PTK=CCMP GTK=TKIP]

I sometime get just



Jan 25 00:57:36 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 25 00:57:36 ostracod kernel: AR_CR=0x00000024
Jan 25 00:57:36 ostracod kernel: AR_DIAG_SW=0x42000020

or

Jan 25 09:39:24 ostracod wpa_supplicant[568]: WPA: Group rekeying
completed with e0:91:f5:48:5b:b9 [GTK=TKIP]
Jan 25 09:41:13 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 25 09:41:13 ostracod kernel: AR_CR=0x00000024
Jan 25 09:41:13 ostracod kernel: AR_DIAG_SW=0x42000020
Jan 25 09:46:50 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 25 09:46:50 ostracod kernel: AR_CR=0x00000024
Jan 25 09:46:50 ostracod kernel: AR_DIAG_SW=0x42000020
Jan 25 09:49:24 ostracod wpa_supplicant[568]: WPA: Group rekeying
completed with e0:91:f5:48:5b:b9 [GTK=TKIP]
Jan 25 09:52:10 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 25 09:52:10 ostracod kernel: AR_CR=0x00000024
Jan 25 09:52:10 ostracod kernel: AR_DIAG_SW=0x42000020
Jan 25 09:57:07 ostracod kernel: ath0: bb hang detected (0x4), resetting

or

Jan 26 17:24:46 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 26 17:24:46 ostracod kernel: AR_CR=0x00000024
Jan 26 17:24:46 ostracod kernel: AR_DIAG_SW=0x42000020
Jan 26 17:25:31 ostracod kernel: ar5416PerCalibrationN: NF calibration
didn't finish; delaying CCA

with no interface flaps.
And sometimes much more info

Jan 25 16:56:27 ostracod kernel: ar5416StopDmaReceive: dma failed to
stop in 10ms
Jan 25 16:56:27 ostracod kernel: AR_CR=0x00000024
Jan 25 16:56:27 ostracod kernel: AR_DIAG_SW=0x42000020
Jan 25 16:56:28 ostracod wpa_supplicant[568]: CTRL-EVENT-DISCONNECTED
bssid=e0:91:f5:48:5b:b9 reason=0
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_print: norm:
node 0xffffff8014828000: bf=0xffffff80008b23e8: addbaw=1, dobaw=1,
seqno=3447, retry=6
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_print: node
0xffffff8014828000: bf=0xffffff80008b23e8: txq[1] axq_depth=0,
axq_aggr_depth=0
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_print: node
0xffffff8014828000: bf=0xffffff80008b23e8: tid txq_depth=10 hwq_depth=0,
bar_wait=1, isfiltered=0
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_print: node
0xffffff8014828000: tid 0: sched=0, paused=1, incomp=0, baw_head=114,
baw_tail=116 txa_start=3446, ni_txseqs=3456
Jan 25 16:56:28 ostracod kernel: TODS
00:24:23:07:fb:5d->e0:91:f5:48:5b:b9(e0:91:f5:48:5b:b9) data QoS [TID 0]
WEP [IV b6 89 00 0c 00 00 KID 0] 0M
Jan 25 16:56:28 ostracod kernel: 8849 0000 e091 f548 5bb9 0024 2307 fb5d
e091 f548 5bb9 70d7 0000 dec0 b689 0020 0c00 0000 aaaa 0300 0000 0800
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3448
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3449
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3450
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3451
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3452
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3453
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3454
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_tid_drain_pkt: wasn't
added: seqno 3455
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008a9e08: seqno 3448: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008aa468: seqno 3449: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008c8a80: seqno 3450: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008cf080: seqno 3451: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008a8488: seqno 3452: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008a64a8: seqno 3453: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008aa930: seqno 3454: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: ath0: ath_tx_default_comp: bf
0xffffff80008a8ae8: seqno 3455: dobaw should've been cleared!
Jan 25 16:56:28 ostracod kernel: wlan0: link state changed to DOWN
Jan 25 16:56:39 ostracod wpa_supplicant[568]: Trying to associate with
e0:91:f5:48:5b:b9 (SSID='vhoff' freq=2462 MHz)
Jan 25 16:56:39 ostracod wpa_supplicant[568]: Associated with
e0:91:f5:48:5b:b9
Jan 25 16:56:39 ostracod kernel: wlan0: link state changed to UP
Jan 25 16:56:40 ostracod wpa_supplicant[568]: WPA: Key negotiation
completed with e0:91:f5:48:5b:b9 [PTK=CCMP GTK=TKIP]


Device is
ath0: <Atheros 9280> mem 0xfebf0000-0xfebfffff irq 16 at device 0.0 on pci4
ath0: [HT] enabling HT modes
ath0: [HT] 2 RX streams; 1 TX streams
ath0: AR9280 mac 128.2 RF5133 phy 13.0
ath0: 2GHz radio: 0x0000; 5GHz radio: 0x00c0

Any suggestions? I'm happy to provide more info if needed.

Vince



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?51051E26.1050300>