Date: Thu, 9 Aug 2012 17:23:25 GMT From: Kim Culhan <w8hdkim@gmail.com> To: freebsd-gnats-submit@FreeBSD.org Subject: kern/170513: ath logs: ath_tx_aggr_comp_aggr: AR5416 bug: Message-ID: <201208091723.q79HNPLD013427@red.freebsd.org> Resent-Message-ID: <201208091730.q79HU1sw007650@freefall.freebsd.org>
next in thread | raw e-mail | index | archive | help
>Number: 170513 >Category: kern >Synopsis: ath logs: ath_tx_aggr_comp_aggr: AR5416 bug: >Confidential: no >Severity: non-critical >Priority: low >Responsible: freebsd-bugs >State: open >Quarter: >Keywords: >Date-Required: >Class: update >Submitter-Id: current-users >Arrival-Date: Thu Aug 09 17:30:01 UTC 2012 >Closed-Date: >Last-Modified: >Originator: Kim Culhan >Release: r239130M >Organization: >Environment: FreeBSD foo@bar 10.0-CURRENT FreeBSD 10.0-CURRENT #7 r239130M: Thu Aug 9 08:18:10 EDT 2012 >Description: The following appeared in /var/log/messages after a fresh boot and within 5 minutes of the start of transferring file data: Aug 9 11:07:08 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=4004 Aug 9 11:07:08 foo kernel: Q1[ 0] (DS.V:0xffffff808ff1b940 DS.P:0x691b940) L:0691b9a0 D:07e5cc5e F:0004 Aug 9 11:07:08 foo kernel: Seq: 64880 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:08 foo kernel: 407f0612 0001102c 24348000 898c8d8e 82df8290 8af983c6 Aug 9 11:07:08 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 11:07:08 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:08 foo kernel: (DS.V:0xffffff808ff1b9a0 DS.P:0x691b9a0) L:0691ba00 D:6cf9cc80 F:0004 Aug 9 11:07:08 foo kernel: Seq: 64880 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:08 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 11:07:08 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:08 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:08 foo kernel: (DS.V:0xffffff808ff1ba00 DS.P:0x691ba00) L:06918c00 D:6c99c9f0 F:0004 Aug 9 11:07:08 foo kernel: Seq: 64880 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:08 foo kernel: 00000000 000005b4 24348000 898c8d8e 00000000 00000000 Aug 9 11:07:08 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 0080302a 00000001 Aug 9 11:07:08 foo kernel: 29c9e43d ffffffff fff7ffff 30802c2c 80808080 80808080 80808080 00001f49 Aug 9 11:07:08 foo kernel: [end] Aug 9 11:07:08 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=13 Aug 9 11:07:16 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=1229 Aug 9 11:07:16 foo kernel: Q1[ 0] (DS.V:0xffffff808ff69000 DS.P:0x6969000) L:06969060 D:07e6025e F:0004 Aug 9 11:07:16 foo kernel: Seq: 20496 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:16 foo kernel: 407f0612 0001102c 24348000 898d8e8f 8241820b 89948285 Aug 9 11:07:16 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 11:07:16 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:16 foo kernel: (DS.V:0xffffff808ff69060 DS.P:0x6969060) L:069690c0 D:07e11a80 F:0004 Aug 9 11:07:16 foo kernel: Seq: 20496 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:16 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 11:07:16 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:16 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:16 foo kernel: (DS.V:0xffffff808ff690c0 DS.P:0x69690c0) L:069600c0 D:6c8ca000 F:0004 Aug 9 11:07:16 foo kernel: Seq: 20496 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:16 foo kernel: 00000000 000005b4 24348000 898d8e8f 00000000 00000000 Aug 9 11:07:16 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 0080312a 00000001 Aug 9 11:07:16 foo kernel: 2a4998af ffffffff 87cfffff 31802e2c 80808080 80808080 80808080 0000099b Aug 9 11:07:16 foo kernel: [end] Aug 9 11:07:16 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=12 Aug 9 11:07:20 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=460 Aug 9 11:07:20 foo kernel: Q1[ 0] (DS.V:0xffffff808ff0ea40 DS.P:0x690ea40) L:0690eaa0 D:6cf9b15e F:0004 Aug 9 11:07:20 foo kernel: Seq: 8032 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:20 foo kernel: 407f0612 0001102c 24348000 898c8d8e 821981e3 87e882bf Aug 9 11:07:20 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 11:07:20 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: (DS.V:0xffffff808ff0eaa0 DS.P:0x690eaa0) L:0690eb00 D:6cf9b480 F:0004 Aug 9 11:07:20 foo kernel: Seq: 8032 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:20 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: (DS.V:0xffffff808ff0eb00 DS.P:0x690eb00) L:0690eb60 D:6cf39b68 F:0004 Aug 9 11:07:20 foo kernel: Seq: 8032 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:20 foo kernel: 00000000 00001498 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 11:07:20 foo kernel: (DS.V:0xffffff808ff0eb60 DS.P:0x690eb60) L:069280c0 D:6cf8e000 F:0004 Aug 9 11:07:20 foo kernel: Seq: 8032 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 11:07:20 foo kernel: 00000000 0000011c 24348000 898c8d8e 00000000 00000000 Aug 9 11:07:20 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 0080312a 00000001 Aug 9 11:07:20 foo kernel: 2a889534 ffffffff fffffbff 31802d2c 80808080 80808080 80808080 00000399 Aug 9 11:07:20 foo kernel: [end] Aug 9 11:07:20 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=10 Several transfers of the same file in each direction failed to produce any further logging of this information. The machine was rebooted and a transfer was done from the client machine --> ath test machine No data was logged. A transfer was started from ath test machine --> client Within a few seconds the following data was logged: Aug 9 13:07:48 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=3847 Aug 9 13:07:48 foo kernel: Q1[ 0] (DS.V:0xffffff808ff32a40 DS.P:0x6932a40) L:06932aa0 D:07ec975e F:0004 Aug 9 13:07:48 foo kernel: Seq: 62192 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:07:49 foo kernel: 407f0612 0001102c 24348000 898c8d8e 8094808a 81d180b8 Aug 9 13:07:49 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 13:07:49 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:07:49 foo kernel: (DS.V:0xffffff808ff32aa0 DS.P:0x6932aa0) L:06932b00 D:719cf880 F:0004 Aug 9 13:07:49 foo kernel: Seq: 62192 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:07:49 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 13:07:49 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:07:49 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:07:49 foo kernel: (DS.V:0xffffff808ff32b00 DS.P:0x6932b00) L:06948840 D:71ce1000 F:0004 Aug 9 13:07:49 foo kernel: Seq: 62192 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:07:49 foo kernel: 00000000 000005b4 24348000 898c8d8e 00000000 00000000 Aug 9 13:07:49 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00803128 00000101 Aug 9 13:07:49 foo kernel: 0e153391 ffffffff fdfffeff 3280302b 80808080 80808080 80808080 00001e0f Aug 9 13:07:49 foo kernel: [end] Aug 9 13:07:49 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=2 Aug 9 13:07:57 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=2684 Aug 9 13:07:57 foo kernel: Q1[ 0] (DS.V:0xffffff808ff2c0c0 DS.P:0x692c0c0) L:0692c120 D:07ab245e F:0004 Aug 9 13:07:57 foo kernel: Seq: 43648 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:07:57 foo kernel: 407f0612 0001102c 24348000 888b8c8d 823281b1 8c528336 Aug 9 13:07:57 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 13:07:57 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:07:57 foo kernel: (DS.V:0xffffff808ff2c120 DS.P:0x692c120) L:0692c180 D:719d4c80 F:0004 Aug 9 13:07:57 foo kernel: Seq: 43648 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:07:57 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 13:07:57 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:07:57 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:07:57 foo kernel: (DS.V:0xffffff808ff2c180 DS.P:0x692c180) L:069180c0 D:719316d0 F:0004 Aug 9 13:07:57 foo kernel: Seq: 43648 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:07:57 foo kernel: 00000000 000005b4 24348000 888b8c8d 00000000 00000000 Aug 9 13:07:57 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00803128 00000001 Aug 9 13:07:57 foo kernel: 0e9acbcc ffffffff ffffefff 31802f2a 80808080 80808080 80808080 000014f9 Aug 9 13:07:57 foo kernel: [end] Aug 9 13:07:57 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=8 Aug 9 13:08:05 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=144 Aug 9 13:08:05 foo kernel: Q1[ 0] (DS.V:0xffffff808ff1bd00 DS.P:0x691bd00) L:0691bd60 D:07ab815e F:0004 Aug 9 13:08:05 foo kernel: Seq: 3136 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:05 foo kernel: 407f0612 0001102c 24348000 888b8c8d 826181d5 8d76837e Aug 9 13:08:05 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 13:08:05 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:05 foo kernel: (DS.V:0xffffff808ff1bd60 DS.P:0x691bd60) L:0691bdc0 D:07eca180 F:0004 Aug 9 13:08:05 foo kernel: Seq: 3136 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:05 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 13:08:05 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:05 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:05 foo kernel: (DS.V:0xffffff808ff1bdc0 DS.P:0x691bdc0) L:0692fd00 D:71ad0000 F:0004 Aug 9 13:08:05 foo kernel: Seq: 3136 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:05 foo kernel: 00000000 000005b4 24348000 888b8c8d 00000000 00000000 Aug 9 13:08:05 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00803025 00000001 Aug 9 13:08:05 foo kernel: 0f164c49 ffffffff ffefffff 30802f29 80808080 80808080 80808080 00000121 Aug 9 13:08:05 foo kernel: [end] Aug 9 13:08:05 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=8 Aug 9 13:08:09 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=980 Aug 9 13:08:09 foo kernel: Q1[ 0] (DS.V:0xffffff808fefc840 DS.P:0x68fc840) L:068fc8a0 D:07ab635e F:0004 Aug 9 13:08:09 foo kernel: Seq: 16512 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:09 foo kernel: 407f0612 0001102c 24348000 898c8d8e 821981e3 87e882bf Aug 9 13:08:09 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 13:08:09 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: (DS.V:0xffffff808fefc8a0 DS.P:0x68fc8a0) L:068fc900 D:71cf0a80 F:0004 Aug 9 13:08:09 foo kernel: Seq: 16512 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:09 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: (DS.V:0xffffff808fefc900 DS.P:0x68fc900) L:068fc960 D:71ad0b68 F:0004 Aug 9 13:08:09 foo kernel: Seq: 16512 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:09 foo kernel: 00000000 00001498 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:08:09 foo kernel: (DS.V:0xffffff808fefc960 DS.P:0x68fc960) L:06908c00 D:71cdf000 F:0004 Aug 9 13:08:09 foo kernel: Seq: 16512 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:08:09 foo kernel: 00000000 0000011c 24348000 898c8d8e 00000000 00000000 Aug 9 13:08:09 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00803028 00000001 Aug 9 13:08:09 foo kernel: 0f4932eb ffffffff ffefffff 30802e2a 80808080 80808080 80808080 000007a9 Aug 9 13:08:09 foo kernel: [end] Aug 9 13:08:09 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=10 ~5 minutes later the same file was transferred in the same direction producing this logging output: Aug 9 13:13:37 foo kernel: ath0: ath_tx_aggr_comp_aggr: AR5416 bug: hasba=0; txok=1, isaggr=1, seq_st=50 Aug 9 13:13:37 foo kernel: Q1[ 0] (DS.V:0xffffff808ff3ee00 DS.P:0x693ee00) L:0693ee60 D:07ab285e F:0004 Aug 9 13:13:37 foo kernel: Seq: 1776 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:13:37 foo kernel: 407f0612 0001102c 24348000 898c8d8e 80a68098 821680ce Aug 9 13:13:37 foo kernel: 08000000 0097bdef 00000000 3f000000 3f000000 3f000000 00000000 00000000 Aug 9 13:13:37 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:13:37 foo kernel: (DS.V:0xffffff808ff3ee60 DS.P:0x693ee60) L:0693eec0 D:71cf0080 F:0004 Aug 9 13:13:37 foo kernel: Seq: 1776 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:13:37 foo kernel: 00000000 00001028 00000000 00000000 00000000 00000000 Aug 9 13:13:37 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:13:37 foo kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Aug 9 13:13:37 foo kernel: (DS.V:0xffffff808ff3eec0 DS.P:0x693eec0) L:0692e2c0 D:71939354 F:0004 Aug 9 13:13:37 foo kernel: Seq: 1776 swtry: 1 ADDBAW?: 1 DOBAW?: 1 Aug 9 13:13:37 foo kernel: 00000000 000005b4 24348000 898c8d8e 00000000 00000000 Aug 9 13:13:37 foo kernel: 08280000 00000000 00000000 00000000 00000000 00000000 00803128 00000001 Aug 9 13:13:37 foo kernel: 22decd06 ffffffff dfffffff 3180302a 80808080 80808080 80808080 00000065 Aug 9 13:13:37 foo kernel: [end] Aug 9 13:13:37 foo kernel: ath0: ath_tx_aggr_comp_aggr: num frames seen=1; bf nframes=3 3 more transfers of the same type were done with no additional info logged. >How-To-Repeat: Transfer a 300MB file using the sftp protocol over a wifi link running the ath wireless nic driver. >Fix: >Release-Note: >Audit-Trail: >Unformatted:
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?201208091723.q79HNPLD013427>