From owner-freebsd-stable Sat Mar 1 1:49:56 2003 Delivered-To: freebsd-stable@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 8CBFE37B401 for ; Sat, 1 Mar 2003 01:49:50 -0800 (PST) Received: from mail.tiscali.it (mail-2.tiscali.it [195.130.225.148]) by mx1.FreeBSD.org (Postfix) with ESMTP id 83C7643F93 for ; Sat, 1 Mar 2003 01:49:49 -0800 (PST) (envelope-from fcasadei@inwind.it) Received: from goku.kasby (217.133.208.227) by mail.tiscali.it (6.5.032) id 3E5CA6F20019FA58 for freebsd-stable@freebsd.org; Sat, 1 Mar 2003 10:49:47 +0100 Received: (qmail 657 invoked by uid 1000); 1 Mar 2003 09:49:34 -0000 Date: Sat, 1 Mar 2003 10:49:34 +0100 From: Francesco Casadei To: Joan Picanyol i Puig Cc: freebsd-stable@freebsd.org Subject: Re: (da0:ahc0:0:0:0): Unexpected busfree in Data-in phase and other weirdness Message-ID: <20030301094934.GA547@goku.kasby> Mail-Followup-To: Joan Picanyol i Puig , freebsd-stable@freebsd.org References: <20030228235031.GE5033@grummit.biaix.org> Mime-Version: 1.0 Content-Type: multipart/signed; micalg=pgp-sha1; protocol="application/pgp-signature"; boundary="EeQfGwPcQSOJBaQU" Content-Disposition: inline In-Reply-To: <20030228235031.GE5033@grummit.biaix.org> User-Agent: Mutt/1.4i X-Operating-System: FreeBSD 4.7-STABLE i386 Sender: owner-freebsd-stable@FreeBSD.ORG Precedence: bulk List-ID: List-Archive: (Web Archive) List-Help: (List Instructions) List-Subscribe: List-Unsubscribe: X-Loop: FreeBSD.ORG --EeQfGwPcQSOJBaQU Content-Type: text/plain; charset=us-ascii Content-Disposition: inline Content-Transfer-Encoding: quoted-printable On Sat, Mar 01, 2003 at 12:50:31AM +0100, Joan Picanyol i Puig wrote: > [reposted from -scsi@, maybe that's not the right place] >=20 > Hi, >=20 > On an Adaptec 2940 I have an IBM DNES-309170W and a SEAGATE ST318438LW, > soft-raided with vinum. Lately it seems that the Seagate disc has become > 'unstable', and I don't know how to diagnose any further. I've checked > the cabling and I've tried the SeaTools floppy disk from Seagate but it > hangs on my system :(=20 >=20 > Please have a look at the excerpt of kernel logs at > http://biaix.org/pk/debug/. messages.1.kernel shows what happened (look > for Feb 4) while recording a cd with my SCSI cd-writer. The system > appeared to hang for anything between 3 and 20 minutes while I was > getting those. messages.0.kernel shows what happened today (Feb 27) for > no apparent reason. Problems persisted across reboots, even though some > of them were not logged (could not fsck). >=20 > For further reference, please look at this thread from two months ago: > http://www.FreeBSD.org/cgi/getmsg.cgi?fetch=3D2329637+0+/usr/local/www/db= /text/2002/freebsd-questions/20021222.freebsd-questions >=20 > I'm really stumped so I'd appreciate any help in the lines of: >=20 > 1.- What's causing these problems? > 2.- How can I solve them? >=20 > tks > --=20 > pica >=20 > To Unsubscribe: send mail to majordomo@FreeBSD.org > with "unsubscribe freebsd-stable" in the body of the message >=20 > end of the original message I'm having this problem too. When this happens the SCSI bus is reset. Here's the error message (not wrapped): Jan 24 12:10:27 goku /kernel: (da1:ahc0:0:1:0): SCB 0x8 - timed out Jan 24 12:10:27 goku /kernel: ahc0: Dumping Card State while idle, at SEQAD= DR 0x8 Jan 24 12:10:27 goku /kernel: ACCUM =3D 0xc0, SINDEX =3D 0x11, DINDEX =3D 0= x8c, ARG_2 =3D 0x0 Jan 24 12:10:27 goku /kernel: HCNT =3D 0x0 SCBPTR =3D 0x0 Jan 24 12:10:27 goku /kernel: SCSISEQ =3D 0x12, SBLKCTL =3D 0x2 Jan 24 12:10:27 goku /kernel: DFCNTRL =3D 0x0, DFSTATUS =3D 0x29 Jan 24 12:10:27 goku /kernel: LASTPHASE =3D 0x1, SCSISIGI =3D 0x0, SXFRCTL0= =3D 0x80 Jan 24 12:10:27 goku /kernel: SSTAT0 =3D 0x5, SSTAT1 =3D 0xa Jan 24 12:10:27 goku /kernel: STACK =3D=3D 0x3, 0xec, 0x147, 0x0 Jan 24 12:10:27 goku /kernel: SCB count =3D 80 Jan 24 12:10:27 goku /kernel: Kernel NEXTQSCB =3D 30 Jan 24 12:10:27 goku /kernel: Card NEXTQSCB =3D 30 Jan 24 12:10:27 goku /kernel: QINFIFO entries:=20 Jan 24 12:10:27 goku /kernel: Waiting Queue entries:=20 Jan 24 12:10:27 goku /kernel: Disconnected Queue entries: 12:13 9:46 8:35 1= 5:3 10:8=20 Jan 24 12:10:27 goku /kernel: QOUTFIFO entries:=20 Jan 24 12:10:27 goku /kernel: Sequencer Free SCB List: 0 13 7 4 3 14 11 5 1= 2 6=20 Jan 24 12:10:27 goku /kernel: Sequencer SCB Info: 0(c 0x68, s 0x17, l 0, t = 0xff) 1(c 0x68, s 0x17, l 0, t 0xff) 2(c 0x68, s 0x17, l 0, t 0xff ) 3(c 0x68, s 0x17, l 0, t 0xff) 4(c 0x68, s 0x17, l 0, t 0xff) 5(c 0x68, s= 0x17, l 0, t 0xff) 6(c 0x68, s 0x17, l 0, t 0xff) 7(c 0x68, s 0x1 7, l 0, t 0xff) 8(c 0x6c, s 0x17, l 0, t 0x23) 9(c 0x6c, s 0x17, l 0, t 0x2= e) 10(c 0x6c, s 0x17, l 0, t 0x8) 11(c 0x68, s 0x17, l 0, t 0xff)=20 12(c 0x6c, s 0x17, l 0, t 0xd) 13(c 0x68, s 0x17, l 0, t 0xff) 14(c 0x68, s= 0x17, l 0, t 0xff) 15(c 0x6c, s 0x17, l 0, t 0x3)=20 Jan 24 12:10:27 goku /kernel: Pending list: 32(c 0x6c, s 0x17, l 0), 5(c 0x= 6c, s 0x17, l 0), 20(c 0x6c, s 0x17, l 0), 59(c 0x6c, s 0x17, l 0) , 4(c 0x6c, s 0x17, l 0), 49(c 0x6c, s 0x17, l 0), 58(c 0x6c, s 0x17, l 0),= 25(c 0x6c, s 0x17, l 0), 13(c 0x68, s 0x17, l 0), 46(c 0x68, s 0x 17, l 0), 35(c 0x68, s 0x17, l 0), 3(c 0x68, s 0x17, l 0), 8(c 0x68, s 0x17= , l 0) Jan 24 12:10:27 goku /kernel: Kernel Free SCB list: 17 26 23 52 12 7 53 44 = 47 34 22 27 54 41 6 43 14 51 69 38 57 10 40 2 62 55 71 36 42 24 18 0 15 39 48 19 67 37 31 45 29 1 28 68 16 33 11 21 56 50 9 66 72 73 74 75 76= 77 78 79 60 61 64 63 65 70=20 Jan 24 12:10:27 goku /kernel: sg[0] - Addr 0x7aa8000 : Length 4096 Jan 24 12:10:27 goku /kernel: sg[1] - Addr 0x7b69000 : Length 4096 Jan 24 12:10:27 goku /kernel: (da1:ahc0:0:1:0): Queuing a BDR SCB Jan 24 12:10:27 goku /kernel: (da1:ahc0:0:1:0): Bus Device Reset Message Se= nt Jan 24 12:10:27 goku /kernel: (da1:ahc0:0:1:0): no longer in timeout, statu= s =3D 34b Jan 24 12:10:27 goku /kernel: ahc0: Bus Device Reset on A:1. 13 SCBs aborted Jan 24 15:19:46 goku login: ROOT LOGIN (root) ON ttyv0 Jan 24 18:22:36 goku /kernel: (da1:ahc0:0:1:0): Unexpected busfree in Data-= in phase Jan 24 18:22:36 goku /kernel: SEQADDR =3D=3D 0x6d Jan 24 18:22:43 goku /kernel: (da1:ahc0:0:1:0): Unexpected busfree in Data-= in phase Jan 24 18:22:43 goku /kernel: SEQADDR =3D=3D 0x6d Jan 24 18:22:50 goku /kernel: (da1:ahc0:0:1:0): Unexpected busfree in Data-= in phase Jan 24 18:22:51 goku /kernel: SEQADDR =3D=3D 0x6c Jan 24 18:22:51 goku /kernel: (da1:ahc0:0:1:0): Invalidating pack Jan 24 18:23:43 goku /kernel: (da1:ahc0:0:1:0): SCB 0xe - timed out Jan 24 18:23:43 goku /kernel: ahc0: Dumping Card State while idle, at SEQAD= DR 0x8 Jan 24 18:23:43 goku /kernel: ACCUM =3D 0x29, SINDEX =3D 0x38, DINDEX =3D 0= x8c, ARG_2 =3D 0x0 Jan 24 18:23:43 goku /kernel: HCNT =3D 0x0 SCBPTR =3D 0x0 Jan 24 18:23:43 goku /kernel: SCSISEQ =3D 0x12, SBLKCTL =3D 0x2 Jan 24 18:23:43 goku /kernel: DFCNTRL =3D 0x0, DFSTATUS =3D 0x29 Jan 24 18:23:43 goku /kernel: LASTPHASE =3D 0x1, SCSISIGI =3D 0x0, SXFRCTL0= =3D 0x80 Jan 24 18:23:43 goku /kernel: SSTAT0 =3D 0x5, SSTAT1 =3D 0xa Jan 24 18:23:43 goku /kernel: STACK =3D=3D 0x3, 0xec, 0x147, 0xcb Jan 24 18:23:43 goku /kernel: SCB count =3D 80 Jan 24 18:23:43 goku /kernel: Kernel NEXTQSCB =3D 78 Jan 24 18:23:43 goku /kernel: Card NEXTQSCB =3D 78 Jan 24 18:23:43 goku /kernel: QINFIFO entries:=20 Jan 24 18:23:43 goku /kernel: Waiting Queue entries:=20 Jan 24 18:23:43 goku /kernel: Disconnected Queue entries: 13:12 6:40 5:41 7= :48 10:14=20 Jan 24 18:23:43 goku /kernel: QOUTFIFO entries:=20 Jan 24 18:23:43 goku /kernel: Sequencer Free SCB List: 0 1 8 15 11 2 12 3 1= 4 4 9=20 Jan 24 18:23:43 goku /kernel: Sequencer SCB Info: 0(c 0x68, s 0x7, l 0, t 0= xff) 1(c 0x68, s 0x7, l 0, t 0xff) 2(c 0x68, s 0x7, l 0, t 0xff) 3 (c 0x68, s 0x7, l 0, t 0xff) 4(c 0x68, s 0x7, l 0, t 0xff) 5(c 0x6c, s 0x17= , l 0, t 0x29) 6(c 0x6c, s 0x17, l 0, t 0x28) 7(c 0x6c, s 0x17, l=20 0, t 0x30) 8(c 0x68, s 0x7, l 0, t 0xff) 9(c 0x68, s 0x7, l 0, t 0xff) 10(c= 0x6c, s 0x17, l 0, t 0xe) 11(c 0x68, s 0x7, l 0, t 0xff) 12(c 0x6 8, s 0x7, l 0, t 0xff) 13(c 0x6c, s 0x17, l 0, t 0xc) 14(c 0x68, s 0x7, l 0= , t 0xff) 15(c 0x68, s 0x7, l 0, t 0xff)=20 Jan 24 18:23:43 goku /kernel: Pending list: 12(c 0x68, s 0x17, l 0), 40(c 0= x68, s 0x17, l 0), 41(c 0x68, s 0x17, l 0), 48(c 0x68, s 0x17, l 0 ), 14(c 0x68, s 0x17, l 0) Jan 24 18:23:43 goku /kernel: Kernel Free SCB list: 56 49 4 20 31 76 52 51 = 8 13 57 77 55 26 53 18 19 16 68 36 42 10 5 47 2 79 34 44 6 1 74 72 33 73 3 25 45 67 23 30 35 59 38 62 50 75 9 7 29 71 46 32 27 21 39 58 0 69 = 22 54 11 15 66 37 43 28 17 24 60 61 64 63 65 70=20 Jan 24 18:23:43 goku /kernel: sg[0] - Addr 0x73e5000 : Length 4096 Jan 24 18:23:43 goku /kernel: sg[1] - Addr 0x3586000 : Length 4096 Jan 24 18:23:43 goku /kernel: sg[2] - Addr 0x4b27000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[3] - Addr 0x1e08000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[4] - Addr 0x2709000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[5] - Addr 0x128a000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[6] - Addr 0x358b000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[7] - Addr 0x472c000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[8] - Addr 0x2a4d000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[9] - Addr 0x68ce000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[10] - Addr 0x340f000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[11] - Addr 0x6f0000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[12] - Addr 0x44b1000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[13] - Addr 0x5452000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[14] - Addr 0xa93000 : Length 4096 Jan 24 18:23:44 goku /kernel: sg[15] - Addr 0x3514000 : Length 4096 Jan 24 18:23:44 goku /kernel: (da1:ahc0:0:1:0): Queuing a BDR SCB Jan 24 18:23:44 goku /kernel: (da1:ahc0:0:1:0): Bus Device Reset Message Se= nt Jan 24 18:23:44 goku /kernel: (da1:ahc0:0:1:0): no longer in timeout, statu= s =3D 34b Jan 24 18:23:44 goku /kernel: ahc0: Bus Device Reset on A:1. 5 SCBs aborted Here's the system configuration: # camcontrol devlist at scbus0 target 0 lun 0 (pass0,da0) at scbus0 target 1 lun 0 (pass1,da1) at scbus0 target 2 lun 0 (pass2,cd0) at scbus0 target 3 lun 0 (pass3,cd1) # dmesg | grep ahc0: ahc0: port 0xd400-0xd4ff mem 0xde000000-0= xde000fff irq 10 at device 11.0 on pci0 # uname -a FreeBSD goku.kasby 4.7-STABLE FreeBSD 4.7-STABLE #1: Thu Dec 26 12:47:59 CE= T 2002 root@goku.kasby:/usr/obj/usr/src/sys/GOKU i386 Francesco Casadei --=20 You can download my public key from http://digilander.libero.it/fcasadei/ or retrieve it from a keyserver (pgpkeys.mit.edu, wwwkeys.pgp.net, ...) Key fingerprint is: 1671 9A23 ACB4 520A E7EE 00B0 7EC3 375F 164E B17B --EeQfGwPcQSOJBaQU Content-Type: application/pgp-signature Content-Disposition: inline -----BEGIN PGP SIGNATURE----- Version: GnuPG v1.2.1 (FreeBSD) iD8DBQE+YIItfsM3XxZOsXsRAvlLAJ4r6A0bkQcyg1EcGgJy5pJ7iOb4EwCglaq9 K5lsU3Aew4vSq2zvpzCdjUY= =OJMp -----END PGP SIGNATURE----- --EeQfGwPcQSOJBaQU-- To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-stable" in the body of the message