Subject: Re: kern/21335: ahc driver leaves process in D state after timeout/BDR
To: None <kern-bug-people@netbsd.org, gnats-admin@netbsd.org,>
From: Paul Ripke <stix@stix.id.au>
List: netbsd-bugs
Date: 10/18/2007 03:45:05
The following reply was made to PR kern/21335; it has been noted by GNATS.

From: Paul Ripke <stix@stix.id.au>
To: NetBSD gnats-bugs <gnats-bugs@NetBSD.org>
Cc: 
Subject: Re: kern/21335: ahc driver leaves process in D state after timeout/BDR
Date: Thu, 18 Oct 2007 12:11:34 +1000

 I can confirm this bug still exists with NetBSD 4.0 RC1.
 
 $ ps alxw | grep xsc
 0  8014 20030   368  -6  0   764     4 xscmd    DW   ?        0:00.09 /sbin/dump -0uat -h 0 -b 64 -f /dev/nrst0 /var
 
 Oct 18 02:28:56 zion /netbsd: ahc0:SCB 0xf - timed out
 Oct 18 02:28:56 zion /netbsd: >>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<<
 Oct 18 02:28:56 zion /netbsd: ahc0: Dumping Card State while idle, at SEQADDR 0x9
 Oct 18 02:28:56 zion /netbsd: Card was paused
 Oct 18 02:28:56 zion /netbsd: ACCUM = 0x4, SINDEX = 0x67, DINDEX = 0x27, ARG_2 = 0x3
 Oct 18 02:28:56 zion /netbsd: HCNT = 0x0 SCBPTR = 0x0
 Oct 18 02:28:56 zion /netbsd: SCSIPHASE[0x0] SCSISIGI[0x0] ERROR[0x0] SCSIBUSL[0x0] 
 Oct 18 02:28:56 zion /netbsd: LASTPHASE[0x1] SCSISEQ[0x12] SBLKCTL[0xa] SCSIRATE[0x0] 
 Oct 18 02:28:56 zion /netbsd: SEQCTL[0x10] SEQ_FLAGS[0xc0] SSTAT0[0x0] SSTAT1[0x8] 
 Oct 18 02:28:56 zion /netbsd: SSTAT2[0x0] SSTAT3[0x0] SIMODE0[0x8] SIMODE1[0xa4] 
 Oct 18 02:28:56 zion /netbsd: SXFRCTL0[0x80] DFCNTRL[0x0] DFSTATUS[0x89] 
 Oct 18 02:28:56 zion /netbsd: STACK: 0x0 0x16b 0x180 0x3
 Oct 18 02:28:56 zion /netbsd: SCB count = 16
 Oct 18 02:28:56 zion /netbsd: Kernel NEXTQSCB = 14
 Oct 18 02:28:56 zion /netbsd: Card NEXTQSCB = 14
 Oct 18 02:28:56 zion /netbsd: QINFIFO entries: 
 Oct 18 02:28:56 zion /netbsd: Waiting Queue entries: 
 Oct 18 02:28:56 zion /netbsd: Disconnected Queue entries: 0:15 
 Oct 18 02:28:56 zion /netbsd: QOUTFIFO entries: 
 Oct 18 02:28:56 zion /netbsd: Sequencer Free SCB List: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 
 Oct 18 02:28:56 zion /netbsd: Sequencer SCB Info: 
 Oct 18 02:28:56 zion /netbsd: 0 SCB_CONTROL[0x44] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0x67] SCB_LUN[0x0] SCB_TAG[0xf] 
 Oct 18 02:28:56 zion /netbsd: 1 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 2 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 3 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 4 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 5 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 6 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 7 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 8 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 9 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 10 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 11 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 12 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 13 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 14 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 15 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 16 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 17 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 18 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 19 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 20 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 21 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 22 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 23 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 24 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 25 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 26 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 27 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 28 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 29 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 30 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 31 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: Pending list: 
 Oct 18 02:28:56 zion /netbsd: 15 SCB_CONTROL[0x40] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0x67] SCB_LUN[0x0] 
 Oct 18 02:28:56 zion /netbsd: Kernel Free SCB list: 13 12 11 10 9 8 7 6 5 4 3 2 1 0 
 Oct 18 02:28:56 zion /netbsd: Untagged Q(6): 15 
 Oct 18 02:28:56 zion /netbsd: 
 Oct 18 02:28:56 zion /netbsd: <<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>>
 Oct 18 02:28:56 zion /netbsd: ahc0:Queuing a BDR SCB
 Oct 18 02:28:56 zion /netbsd: ahc0:Bus Device Reset Message Sent
 Oct 18 02:28:56 zion /netbsd: st0(ahc0:0:6:0): ahc0: no longer in timeout, status = 0
 Oct 18 02:28:56 zion /netbsd: ahc0:A:6: no active SCB for reconnecting target - issuing BUS DEVICE RESET
 Oct 18 02:28:56 zion /netbsd: SAVED_SCSIID == 0x67, SAVED_LUN == 0x0, ARG_1 == 0xf ACCUM = 0x0
 Oct 18 02:28:56 zion /netbsd: SEQ_FLAGS == 0xc0, SCBPTR == 0x0, BTT == 0xf, SINDEX == 0x31
 Oct 18 02:28:56 zion /netbsd: SCSIID == 0x0, SCB_SCSIID == 0x67, SCB_LUN == 0x0, SCB_TAG == 0xff, SCB_CONTROL == 0x0
 Oct 18 02:28:56 zion /netbsd: SCSIBUSL == 0x80, SCSISIGI == 0xe6
 Oct 18 02:28:56 zion /netbsd: SXFRCTL0 == 0x88
 Oct 18 02:28:56 zion /netbsd: SEQCTL == 0x10
 Oct 18 02:28:56 zion /netbsd: >>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<<
 Oct 18 02:28:56 zion /netbsd: ahc0: Dumping Card State in Message-in phase, at SEQADDR 0x1ae
 Oct 18 02:28:56 zion /netbsd: Card was paused
 Oct 18 02:28:56 zion /netbsd: ACCUM = 0x0, SINDEX = 0x31, DINDEX = 0xe4, ARG_2 = 0x3
 Oct 18 02:28:56 zion /netbsd: HCNT = 0x0 SCBPTR = 0x0
 Oct 18 02:28:56 zion /netbsd: SCSIPHASE[0x8] SCSISIGI[0xe6] ERROR[0x0] SCSIBUSL[0x80] 
 Oct 18 02:28:56 zion /netbsd: LASTPHASE[0xe0] SCSISEQ[0x12] SBLKCTL[0xa] SCSIRATE[0x0] 
 Oct 18 02:28:56 zion /netbsd: SEQCTL[0x10] SEQ_FLAGS[0xc0] SSTAT0[0x2] SSTAT1[0x11] 
 Oct 18 02:28:56 zion /netbsd: SSTAT2[0x0] SSTAT3[0x0] SIMODE0[0x8] SIMODE1[0xac] 
 Oct 18 02:28:56 zion /netbsd: SXFRCTL0[0x88] DFCNTRL[0x0] DFSTATUS[0x89] 
 Oct 18 02:28:56 zion /netbsd: STACK: 0x147 0x0 0x16b 0x180
 Oct 18 02:28:56 zion /netbsd: SCB count = 16
 Oct 18 02:28:56 zion /netbsd: Kernel NEXTQSCB = 14
 Oct 18 02:28:56 zion /netbsd: Card NEXTQSCB = 14
 Oct 18 02:28:56 zion /netbsd: QINFIFO entries: 
 Oct 18 02:28:56 zion /netbsd: Waiting Queue entries: 
 Oct 18 02:28:56 zion /netbsd: Disconnected Queue entries: 
 Oct 18 02:28:56 zion /netbsd: QOUTFIFO entries: 
 Oct 18 02:28:56 zion /netbsd: Sequencer Free SCB List: 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 
 Oct 18 02:28:56 zion /netbsd: Sequencer SCB Info: 
 Oct 18 02:28:56 zion /netbsd: 0 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0x67] SCB_LUN[0x0] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 1 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 2 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 3 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 4 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 5 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 6 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 7 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 8 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 9 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 10 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 11 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 12 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 13 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 14 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 15 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 16 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 17 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 18 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 19 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 20 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 21 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 22 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 23 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 24 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 25 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 26 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 27 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 28 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 29 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 30 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: 31 SCB_CONTROL[0x0] 
 Oct 18 02:28:56 zion /netbsd: SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 
 Oct 18 02:28:56 zion /netbsd: Pending list: 
 Oct 18 02:28:56 zion /netbsd: Kernel Free SCB list: 15 13 12 11 10 9 8 7 6 5 4 3 2 1 0 
 Oct 18 02:28:56 zion /netbsd: 
 Oct 18 02:28:56 zion /netbsd: <<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>>