From owner-freebsd-wireless@FreeBSD.ORG Thu Feb 2 20:27:32 2012 Return-Path: Delivered-To: freebsd-wireless@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id ED4081065670; Thu, 2 Feb 2012 20:27:32 +0000 (UTC) (envelope-from lev@serebryakov.spb.ru) Received: from onlyone.friendlyhosting.spb.ru (onlyone.friendlyhosting.spb.ru [IPv6:2a01:4f8:131:60a2::2]) by mx1.freebsd.org (Postfix) with ESMTP id 716818FC0C; Thu, 2 Feb 2012 20:27:32 +0000 (UTC) Received: from lion.home.serebryakov.spb.ru (unknown [IPv6:2001:470:923f:1:24ed:86dc:9f3b:9149]) (Authenticated sender: lev@serebryakov.spb.ru) by onlyone.friendlyhosting.spb.ru (Postfix) with ESMTPA id F30DF4AC2D; Fri, 3 Feb 2012 00:27:30 +0400 (MSK) Date: Fri, 3 Feb 2012 00:27:26 +0400 From: Lev Serebryakov X-Priority: 3 (Normal) Message-ID: <208667374.20120203002726@serebryakov.spb.ru> To: Adrian Chadd In-Reply-To: References: <743722267.20120202195757@serebryakov.spb.ru> <1292923023.20120202232810@serebryakov.spb.ru> MIME-Version: 1.0 Content-Type: text/plain; charset=windows-1251 Content-Transfer-Encoding: quoted-printable Cc: freebsd-wireless@freebsd.org Subject: Re: "ath0: device timeout" when environment is clear X-BeenThere: freebsd-wireless@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: "Discussions of 802.11 stack, tools device driver development." List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 02 Feb 2012 20:27:33 -0000 Hello, Adrian. You wrote 2 =F4=E5=E2=F0=E0=EB=FF 2012 =E3., 23:32:17: > Please file a bug so I don't forget. I'll do this several hours later. > What you can do is flip on reset debugging in the driver (look at > if_ath_debug.h for ATH_DEBUG_RESET) - not the HAL debugging, just > the reset debugging) - that should make ath_draintxq() print out the > contents of the TX queue before its drained. > I'd like to see if there's anything in the TX queue when the NIC is > reset. Chances are there are; I'd like to see what it is and whether > it's completed or not. Here it is ath0: stuck beacon; resetting (bmiss count 4) ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x212fb40, link 0 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0x20beb40, link 0 ar5212StopDmaReceive: dma failed to stop in 10ms AR_CR=3D0x00000024 AR_DIAG_SW=3D0x42000020 ath_stoprecv: rx queue 0x1b96480, link 0xcdb96420 ath0: stuck beacon; resetting (bmiss count 4) ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20bc780, link 0xd58c6420 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0x20fe3c0, link 0 ath_stoprecv: rx queue 0x1b90660, link 0xcdb90600 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20c63c0, link 0xd58b5060 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b94d20, link 0xcdb94c00 R[ 0] (DS.V:0xcdb94c60 DS.P:0x1b94c60) L:01b94cc0 D:18d33000 ! aa55aa55 00000800 1b800005 0000013a ath0: ath_start: sc_inreset_cnt > 0; bailing 008b0a6d 00000100 06808080 80808080 80808080 80808080 00000005 R[ 1] (DS.V:0xcdb94cc0 DS.P:0x1b94cc0) L:01b94d20 D:137c6000 * aa55aa55 00000800 1b800b10 00000031 008b3700 00000100 11808080 80808080 80808080 80808080 00000003 ath0: ath_raw_xmit: sc_inreset_cnt > 0; bailing ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20b5000, link 0xd58c57e0 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b977e0, link 0xcdb976c0 R[ 0] (DS.V:0xcdb97720 DS.P:0x1b97720) L:01b97780 D:08942000 * aa55aa55 00000800 1b800a0c 00000112 004cddcf 00000100 0e808080 80808080 80808080 80808080 00000003 R[ 1] (DS.V:0xcdb97780 DS.P:0x1b97780) L:01b977e0 D:136f1000 * aa55aa55 00000800 1b800304 000000a2 004cf785 00000100 06808080 80808080 80808080 80808080 00000003 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20c5780, link 0xd58b2060 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b8e600, link 0xcdb8e540 R[ 0] (DS.V:0xcdb8e5a0 DS.P:0x1b8e5a0) L:01b8e600 D:13706000 ! aa55aa55 00000800 1b800f0a 0000008e 004d8f1e 00000100 11808080 80808080 80808080 80808080 00000611 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20b2000, link 0xd58cb420 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b922a0, link 0xcdb92180 R[ 0] (DS.V:0xcdb921e0 DS.P:0x1b921e0) L:01b92240 D:18ced000 * aa55aa55 00000800 1b80060e 00000112 006b3c79 00000100 0f808080 80808080 80808080 80808080 00000003 R[ 1] (DS.V:0xcdb92240 DS.P:0x1b92240) L:01b922a0 D:136e0800 * aa55aa55 00000800 1b800306 000000a2 006b536b 00000100 08808080 80808080 80808080 80808080 00000003 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20cb3c0, link 0xd58c9b40 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b95420, link 0xcdb95360 R[ 0] (DS.V:0xcdb953c0 DS.P:0x1b953c0) L:01b95420 D:18d1c000 * aa55aa55 00000800 1b80040a 00000112 007aafb5 00000100 0b808080 80808080 80808080 80808080 00000003 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20c9b40, link 0xd592f420 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0x20ca780, link 0 ath_stoprecv: rx queue 0x1b98e40, link 0xcdb98de0 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x212f3c0, link 0xd592ab40 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0x20bcb40, link 0 ath_stoprecv: rx queue 0x1b95420, link 0xcdb95360 R[ 0] (DS.V:0xcdb953c0 DS.P:0x1b953c0) L:01b95420 D:18c5a000 * aa55aa55 00000800 1b80090e 00000112 01227240 00000100 0f808080 80808080 80808080 80808080 00000003 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x212ab40, link 0xd58cf780 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b99540, link 0xcdb99480 R[ 0] (DS.V:0xcdb994e0 DS.P:0x1b994e0) L:01b99540 D:1374a000 * aa55aa55 00000800 1b80070c 00000112 00a885b6 00000100 0d808080 80808080 80808080 80808080 00000003 ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20cf780, link 0xd58e2000 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b95180, link 0xcdb95060 R[ 0] (DS.V:0xcdb950c0 DS.P:0x1b950c0) L:01b95120 D:17100000 * aa55aa55 00000800 1b80110c 00000147 01045026 00000100 12808080 80808080 80808080 80808080 00000003 R[ 1] (DS.V:0xcdb95120 DS.P:0x1b95120) L:01b95180 D:18cbf800 ! aa55aa55 00000800 1b80070a 0000006a 01045e67 00000100 0c808080 80808080 80808080 80808080 00000005 ath0: ath_tx_tid_drain: node 0xc4d8b000: tid 16: txq_depth=3D28, txq_aggr_d= epth=3D0, sched=3D0, paused=3D0, hwq_depth=3D0, incomp=3D0, baw_head=3D0, b= aw_tail=3D0 txa_start=3D-1, ni_txseqs=3D11 FRDS f4:ec:38:a3:10:6d->00:18:de:08:e8:1d(f4:ec:38:a3:10:6d) data WEP [IV 7= c 99 00 05 00 00 KID 0] 0M 0842 3a01 0018 de08 e81d f4ec 38a3 106d f4ec 38a3 106d 6000 7c99 0020 0500= 0000 aaaa 0300 0000 888e ath0: device timeout ath0: ath_reset: called ath0: ath_stoptxdma: tx queue [9] 0x1b9b000, link 0 ath0: ath_tx_stopdma: tx queue [0] 0, link 0 ath0: ath_tx_stopdma: tx queue [1] 0x20e2000, link 0xd58baba0 ath0: ath_tx_stopdma: tx queue [2] 0, link 0 ath0: ath_tx_stopdma: tx queue [3] 0, link 0 ath0: ath_tx_stopdma: tx queue [8] 0, link 0 ath_stoprecv: rx queue 0x1b98840, link 0xcdb987e0 --=20 // Black Lion AKA Lev Serebryakov