Bug 5921 - AIC7xxx: SCSI bus crash when formating CDRW
Summary: AIC7xxx: SCSI bus crash when formating CDRW
Status: CLOSED OBSOLETE
Alias: None
Product: SCSI Drivers
Classification: Unclassified
Component: Other (show other bugs)
Hardware: i386 Linux
: P2 high
Assignee: linux-scsi@vger.kernel.org
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2006-01-19 01:33 UTC by Emmanuel Fust
Modified: 2012-05-12 01:33 UTC (History)
3 users (show)

See Also:
Kernel Version: 2.6.25
Subsystem:
Regression: No
Bisected commit-id:

Attachments
Kernel Log (16.39 KB, application/x-gzip)
2006-01-19 01:39 UTC, Emmanuel Fust 		Details
New kernel log (15.24 KB, application/gzip)
2006-02-01 14:22 UTC, Emmanuel Fust 		Details
Patch 0 (4.21 KB, patch)
2006-03-29 08:00 UTC, Emmanuel Fust 		Details | Diff
Patch 1/5 (6.53 KB, patch)
2006-03-29 08:01 UTC, Emmanuel Fust 		Details | Diff
Patch 2/5 (685 bytes, patch)
2006-03-29 08:02 UTC, Emmanuel Fust 		Details | Diff
Patch 3/5 (1.91 KB, patch)
2006-03-29 08:03 UTC, Emmanuel Fust 		Details | Diff
Patch 4/5 (1.31 KB, patch)
2006-03-29 08:03 UTC, Emmanuel Fust 		Details | Diff
Patch 5/5 (11.07 KB, patch)
2006-03-29 08:04 UTC, Emmanuel Fust 		Details | Diff
Patch 6/5 (595 bytes, patch)
2006-03-29 08:04 UTC, Emmanuel Fust 		Details | Diff
crash log march 30 2008 (230.46 KB, application/octet-stream)
2008-03-30 11:55 UTC, Emmanuel Fust 		Details
Add an attachment (proposed patch, testcase, etc.)

Description Emmanuel Fust 2006-01-19 01:33:32 UTC 
Hello,

I recently made the switch from 2.4.26 to 2.6.13 and 2.6.14rc5 on my old
dual 586mmx 233mhz.

I've got many problems with SMP on 2.6.13 (bad irq balancing/routing
very bad performance on IDE and SCSI) but I tried to use the long
awaited CDRW support.
I format a disc with cdrwtools -d/dev/cdrw -t4 -q
the initialisation of the disc start and ~5min later I got :

Oct 20 20:44:57 rafale kernel: scsi0:0:3:0: Attempting to queue an ABORT message
Oct 20 20:44:57 rafale kernel: CDB: 0x4 0x17 0x0 0x0 0x0 0x0
Oct 20 20:44:57 rafale kernel: scsi0: At time of recovery, card was not paused
Oct 20 20:44:57 rafale kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins \
                <<<<<<<<<<<<<<<<<
Oct 20 20:44:57 rafale kernel: scsi0: Dumping Card State while idle, at SEQADDR 0x9
Oct 20 20:44:57 rafale kernel: Card was paused
Oct 20 20:44:57 rafale kernel: ACCUM = 0x0, SINDEX = 0x4, DINDEX = 0xe4, ARG_2 = 0x0
Oct 20 20:44:57 rafale kernel: HCNT = 0x0 SCBPTR = 0x7
Oct 20 20:44:57 rafale kernel: SCSISIGI[0x0] ERROR[0x0] SCSIBUSL[0x0] \
                LASTPHASE[0x1]:(P_BUSFREE) 
Oct 20 20:44:57 rafale kernel: SCSISEQ[0x12]:(ENAUTOATNP|ENRSELI) \
                SBLKCTL[0xa]:(SELWIDE|SELBUSB) 
Oct 20 20:44:57 rafale kernel: SCSIRATE[0x0] SEQCTL[0x10]:(FASTMODE) \
                SEQ_FLAGS[0xc0]:(NO_CDB_SENT|NOT_IDENTIFIED) 
Oct 20 20:44:57 rafale kernel: SSTAT0[0x0] SSTAT1[0xa]:(PHASECHG|BUSFREE)
SSTAT2[0x0] \
                
Oct 20 20:44:57 rafale kernel: SSTAT3[0x0] SIMODE0[0x8]:(ENSWRAP) \
                SIMODE1[0xa4]:(ENSCSIPERR|ENSCSIRST|ENSELTIMO) 
Oct 20 20:44:57 rafale kernel: SXFRCTL0[0x80]:(DFON) DFCNTRL[0x0] \
                DFSTATUS[0x89]:(FIFOEMP|HDONE|PRELOAD_AVAIL) 
Oct 20 20:44:57 rafale kernel: STACK: 0x0 0x166 0x10c 0x3
Oct 20 20:44:57 rafale kernel: SCB count = 12
Oct 20 20:44:57 rafale kernel: Kernel NEXTQSCB = 2
Oct 20 20:44:57 rafale kernel: Card NEXTQSCB = 2
Oct 20 20:44:57 rafale kernel: QINFIFO entries: 
Oct 20 20:44:57 rafale kernel: Waiting Queue entries: 
Oct 20 20:44:57 rafale kernel: Disconnected Queue entries: 0:11 
Oct 20 20:44:57 rafale kernel: QOUTFIFO entries: 
Oct 20 20:44:57 rafale kernel: Sequencer Free SCB List: 7 4 5 3 1 8 6 2 9 10 11
12 13 \
                14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 
Oct 20 20:44:57 rafale kernel: Sequencer SCB Info: 
Oct 20 20:44:57 rafale kernel:   0 SCB_CONTROL[0x44]:(DISCONNECTED|DISCENB) \
                SCB_SCSIID[0x37] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xb] 
Oct 20 20:44:57 rafale kernel:   1 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   2 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   3 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   4 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   5 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   6 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   7 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   8 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:   9 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  10 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  11 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  12 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  13 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  14 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  15 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  16 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  17 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  18 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  19 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  20 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  21 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  22 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  23 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  24 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  25 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  26 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  27 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  28 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  29 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  30 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel:  31 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 20 20:44:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 20 20:44:57 rafale kernel: Pending list: 
Oct 20 20:44:57 rafale kernel:  11 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 20 20:44:57 rafale kernel: Kernel Free SCB list: 4 1 0 5 7 3 6 10 9 8 
Oct 20 20:44:57 rafale kernel: Untagged Q(3): 11 
Oct 20 20:44:57 rafale kernel: 
Oct 20 20:44:57 rafale kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends \
                >>>>>>>>>>>>>>>>>>
Oct 20 20:44:57 rafale kernel: (scsi0:A:3:0): Device is disconnected, re-queuing SCB
Oct 20 20:44:57 rafale kernel: Recovery code sleeping
Oct 20 20:44:57 rafale kernel: Recovery SCB completes
Oct 20 20:44:57 rafale kernel: Recovery code awake
Oct 20 20:44:57 rafale kernel: aic7xxx_abort returns 0x2002
Oct 20 20:44:57 rafale kernel: scsi0:0:3:0: Attempting to queue a TARGET RESET \
                message
Oct 20 20:44:57 rafale kernel: CDB: 0x4 0x17 0x0 0x0 0x0 0x0
Oct 20 20:44:57 rafale kernel: scsi0:0:3:0: Command not found
Oct 20 20:44:57 rafale kernel: aic7xxx_dev_reset returns 0x2002
Oct 20 20:45:08 rafale kernel: scsi: Device offlined - not ready after error \
                recovery: host 0 channel 0 id 3 lun 0
Oct 20 20:45:08 rafale kernel: scsi0 (3:0): rejecting I/O to offline device



Now I use a 2.6.14rc5 kernel with great results from a performance stand
point: no longer bad SMP IRQ routing/balancing, good perfs for IDE and
SCSI disc but when I try to blank a disc with the same command:
cdrwtools -d/dev/cdrw -t4 -q
Nothing append and the cd-writer/scsi bus directly crash:
Oct 26 21:07:57 rafale kernel: scsi0:0:3:0: Attempting to queue an ABORT message
Oct 26 21:07:57 rafale kernel: CDB: 0x5c 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xc 0x0 0x0 0x0
Oct 26 21:07:57 rafale kernel: scsi0: At time of recovery, card was not paused
Oct 26 21:07:57 rafale kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins \
                <<<<<<<<<<<<<<<<<
Oct 26 21:07:57 rafale kernel: scsi0: Dumping Card State in Command phase, at
SEQADDR \
                0xb8
Oct 26 21:07:57 rafale kernel: Card was paused
Oct 26 21:07:57 rafale kernel: ACCUM = 0x80, SINDEX = 0xa0, DINDEX = 0xe4, ARG_2 = \
                0x1
Oct 26 21:07:57 rafale kernel: HCNT = 0xc SCBPTR = 0x4
Oct 26 21:07:57 rafale kernel: SCSISIGI[0x44]:(BSYI|IOI) ERROR[0x0] SCSIBUSL[0x0] 
Oct 26 21:07:57 rafale kernel: LASTPHASE[0x80]:(CDI) \
                SCSISEQ[0x12]:(ENAUTOATNP|ENRSELI) 
Oct 26 21:07:57 rafale kernel: SBLKCTL[0xa]:(SELWIDE|SELBUSB) \
                SCSIRATE[0x18]:(SINGLE_EDGE) 
Oct 26 21:07:57 rafale kernel: SEQCTL[0x10]:(FASTMODE) SEQ_FLAGS[0x0] SSTAT0[0x0] 
Oct 26 21:07:57 rafale kernel: SSTAT1[0x3]:(REQINIT|PHASECHG) \
                SSTAT2[0x50]:(EXP_ACTIVE|SHVALID) 
Oct 26 21:07:57 rafale kernel: SSTAT3[0xc] SIMODE0[0x8]:(ENSWRAP) \
                SIMODE1[0xac]:(ENSCSIPERR|ENBUSFREE|ENSCSIRST|ENSELTIMO) 
Oct 26 21:07:57 rafale kernel: SXFRCTL0[0x80]:(DFON)
DFCNTRL[0x24]:(DIRECTION|SCSIEN) \
                
Oct 26 21:07:57 rafale kernel: DFSTATUS[0x80]:(PRELOAD_AVAIL) 
Oct 26 21:07:57 rafale kernel: STACK: 0x0 0x167 0x17d 0x35
Oct 26 21:07:57 rafale kernel: SCB count = 12
Oct 26 21:07:57 rafale kernel: Kernel NEXTQSCB = 6
Oct 26 21:07:57 rafale kernel: Card NEXTQSCB = 6
Oct 26 21:07:57 rafale kernel: QINFIFO entries: 
Oct 26 21:07:57 rafale kernel: Waiting Queue entries: 
Oct 26 21:07:57 rafale kernel: Disconnected Queue entries: 
Oct 26 21:07:57 rafale kernel: QOUTFIFO entries: 
Oct 26 21:07:57 rafale kernel: Sequencer Free SCB List: 8 0 7 5 3 6 1 2 9 10 11
12 13 \
                14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 
Oct 26 21:07:57 rafale kernel: Sequencer SCB Info: 
Oct 26 21:07:57 rafale kernel:   0 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   1 SCB_CONTROL[0x80]:(TARGET_SCB) SCB_SCSIID[0x47] \
                SCB_LUN[0x0] 
Oct 26 21:07:57 rafale kernel: SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   2 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   3 SCB_CONTROL[0x80]:(TARGET_SCB) SCB_SCSIID[0x47] \
                SCB_LUN[0x0] 
Oct 26 21:07:57 rafale kernel: SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   4 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 26 21:07:57 rafale kernel: SCB_TAG[0x7] 
Oct 26 21:07:57 rafale kernel:   5 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   6 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   7 SCB_CONTROL[0x80]:(TARGET_SCB) SCB_SCSIID[0x47] \
                SCB_LUN[0x0] 
Oct 26 21:07:57 rafale kernel: SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   8 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:   9 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  10 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  11 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  12 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  13 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  14 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  15 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  16 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  17 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  18 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  19 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  20 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  21 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  22 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  23 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  24 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  25 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  26 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  27 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  28 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  29 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  30 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel:  31 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:07:57 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:07:57 rafale kernel: Pending list: 
Oct 26 21:07:57 rafale kernel:   7 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 26 21:07:57 rafale kernel: Kernel Free SCB list: 3 5 4 0 11 2 1 10 9 8 
Oct 26 21:07:57 rafale kernel: Untagged Q(3): 7 
Oct 26 21:07:57 rafale kernel: 
Oct 26 21:07:57 rafale kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends \
                >>>>>>>>>>>>>>>>>>
Oct 26 21:07:57 rafale kernel: scsi0:0:3:0: Device is active, asserting ATN
Oct 26 21:07:57 rafale kernel: Recovery code sleeping
Oct 26 21:07:57 rafale kernel: (scsi0:A:3:0): Abort Message Sent
Oct 26 21:07:57 rafale kernel: (scsi0:A:3:0): Recovery SCB completes
Oct 26 21:07:57 rafale kernel: Recovery code awake
Oct 26 21:07:57 rafale kernel: Unexpected busfree in Message-out phase
Oct 26 21:07:57 rafale kernel: SEQADDR == 0x1a8
Oct 26 21:07:57 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:3:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x5c 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xc 0x0 0x0 0x0
Oct 26 21:08:58 rafale kernel: scsi0: At time of recovery, card was not paused
Oct 26 21:08:58 rafale kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins \
                <<<<<<<<<<<<<<<<<
Oct 26 21:08:58 rafale kernel: scsi0: Dumping Card State in Command phase, at
SEQADDR \
                0xb8
Oct 26 21:08:58 rafale kernel: Card was paused
Oct 26 21:08:58 rafale kernel: ACCUM = 0x80, SINDEX = 0xa0, DINDEX = 0xe4, ARG_2 = \
                0x1
Oct 26 21:08:58 rafale kernel: HCNT = 0xc SCBPTR = 0x4
Oct 26 21:08:58 rafale kernel: SCSISIGI[0x44]:(BSYI|IOI) ERROR[0x0] SCSIBUSL[0x0] 
Oct 26 21:08:58 rafale kernel: LASTPHASE[0x80]:(CDI) \
                SCSISEQ[0x12]:(ENAUTOATNP|ENRSELI) 
Oct 26 21:08:58 rafale kernel: SBLKCTL[0xa]:(SELWIDE|SELBUSB) \
                SCSIRATE[0x18]:(SINGLE_EDGE) 
Oct 26 21:08:58 rafale kernel: SEQCTL[0x10]:(FASTMODE) SEQ_FLAGS[0x0] SSTAT0[0x0] 
Oct 26 21:08:58 rafale kernel: SSTAT1[0x3]:(REQINIT|PHASECHG) \
                SSTAT2[0x50]:(EXP_ACTIVE|SHVALID) 
Oct 26 21:08:58 rafale kernel: SSTAT3[0xc] SIMODE0[0x8]:(ENSWRAP) \
                SIMODE1[0xac]:(ENSCSIPERR|ENBUSFREE|ENSCSIRST|ENSELTIMO) 
Oct 26 21:08:58 rafale kernel: SXFRCTL0[0x80]:(DFON)
DFCNTRL[0x24]:(DIRECTION|SCSIEN) \
                
Oct 26 21:08:58 rafale kernel: DFSTATUS[0x80]:(PRELOAD_AVAIL) 
Oct 26 21:08:58 rafale kernel: STACK: 0xe4 0x167 0x17d 0x35
Oct 26 21:08:58 rafale kernel: SCB count = 12
Oct 26 21:08:58 rafale kernel: Kernel NEXTQSCB = 10
Oct 26 21:08:58 rafale kernel: Card NEXTQSCB = 7
Oct 26 21:08:58 rafale kernel: QINFIFO entries: 7 3 5 4 0 11 2 1 
Oct 26 21:08:58 rafale kernel: Waiting Queue entries: 
Oct 26 21:08:58 rafale kernel: Disconnected Queue entries: 
Oct 26 21:08:58 rafale kernel: QOUTFIFO entries: 
Oct 26 21:08:58 rafale kernel: Sequencer Free SCB List: 8 0 7 5 3 6 1 2 9 10 11
12 13 \
                14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 
Oct 26 21:08:58 rafale kernel: Sequencer SCB Info: 
Oct 26 21:08:58 rafale kernel:   0 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   1 SCB_CONTROL[0x80]:(TARGET_SCB) SCB_SCSIID[0x47] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   2 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   3 SCB_CONTROL[0x80]:(TARGET_SCB) SCB_SCSIID[0x47] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   4 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: SCB_TAG[0x6] 
Oct 26 21:08:58 rafale kernel:   5 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   6 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   7 SCB_CONTROL[0x80]:(TARGET_SCB) SCB_SCSIID[0x47] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   8 SCB_CONTROL[0xe0]:(TAG_ENB|DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   9 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  10 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  11 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  12 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  13 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  14 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  15 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  16 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  17 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  18 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  19 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  20 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  21 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  22 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  23 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  24 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  25 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  26 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  27 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  28 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  29 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  30 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  31 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel: Pending list: 
Oct 26 21:08:58 rafale kernel:   1 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   2 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:  11 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   0 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   4 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   5 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   3 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   7 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   6 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: Kernel Free SCB list: 9 8 
Oct 26 21:08:58 rafale kernel: Untagged Q(3): 6 
Oct 26 21:08:58 rafale kernel: 
Oct 26 21:08:58 rafale kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends \
                >>>>>>>>>>>>>>>>>>
Oct 26 21:08:58 rafale kernel: scsi0:0:3:0: Device is active, asserting ATN
Oct 26 21:08:58 rafale kernel: Recovery code sleeping
Oct 26 21:08:58 rafale kernel: (scsi0:A:3:0): Abort Message Sent
Oct 26 21:08:58 rafale kernel: (scsi0:A:3:0): Recovery SCB completes
Oct 26 21:08:58 rafale kernel: Unexpected busfree in Message-out phase
Oct 26 21:08:58 rafale kernel: SEQADDR == 0x1a8
Oct 26 21:08:58 rafale kernel: Recovery code awake
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x81 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x8a 0x2b 0xa1 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0xa2 0xef 0x1 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0xa2 0xef 0x59 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x19 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x31 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x91 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x8a 0x2b 0xa9 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:3:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x5c 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xc 0x0 0x0 0x0
Oct 26 21:08:58 rafale kernel: scsi0: At time of recovery, card was not paused
Oct 26 21:08:58 rafale kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins \
                <<<<<<<<<<<<<<<<<
Oct 26 21:08:58 rafale kernel: scsi0: Dumping Card State in Command phase, at
SEQADDR \
                0xb7
Oct 26 21:08:58 rafale kernel: Card was paused
Oct 26 21:08:58 rafale kernel: ACCUM = 0x80, SINDEX = 0xa0, DINDEX = 0xe4, ARG_2 = \
                0x2
Oct 26 21:08:58 rafale kernel: HCNT = 0xc SCBPTR = 0x4
Oct 26 21:08:58 rafale kernel: SCSISIGI[0x44]:(BSYI|IOI) ERROR[0x0] SCSIBUSL[0x0] 
Oct 26 21:08:58 rafale kernel: LASTPHASE[0x80]:(CDI) \
                SCSISEQ[0x12]:(ENAUTOATNP|ENRSELI) 
Oct 26 21:08:58 rafale kernel: SBLKCTL[0xa]:(SELWIDE|SELBUSB) \
                SCSIRATE[0x18]:(SINGLE_EDGE) 
Oct 26 21:08:58 rafale kernel: SEQCTL[0x10]:(FASTMODE) SEQ_FLAGS[0x0] SSTAT0[0x0] 
Oct 26 21:08:58 rafale kernel: SSTAT1[0x3]:(REQINIT|PHASECHG) \
                SSTAT2[0x50]:(EXP_ACTIVE|SHVALID) 
Oct 26 21:08:58 rafale kernel: SSTAT3[0xc] SIMODE0[0x8]:(ENSWRAP) \
                SIMODE1[0xac]:(ENSCSIPERR|ENBUSFREE|ENSCSIRST|ENSELTIMO) 
Oct 26 21:08:58 rafale kernel: SXFRCTL0[0x80]:(DFON)
DFCNTRL[0x24]:(DIRECTION|SCSIEN) \
                
Oct 26 21:08:58 rafale kernel: DFSTATUS[0x80]:(PRELOAD_AVAIL) 
Oct 26 21:08:58 rafale kernel: STACK: 0xe4 0x167 0x17d 0x35
Oct 26 21:08:58 rafale kernel: SCB count = 12
Oct 26 21:08:58 rafale kernel: Kernel NEXTQSCB = 6
Oct 26 21:08:58 rafale kernel: Card NEXTQSCB = 3
Oct 26 21:08:58 rafale kernel: QINFIFO entries: 3 
Oct 26 21:08:58 rafale kernel: Waiting Queue entries: 
Oct 26 21:08:58 rafale kernel: Disconnected Queue entries: 8:0 5:11 3:2 6:5 0:4
7:1 \
                1:7 
Oct 26 21:08:58 rafale kernel: QOUTFIFO entries: 
Oct 26 21:08:58 rafale kernel: Sequencer Free SCB List: 2 9 10 11 12 13 14 15 16
17 \
                18 19 20 21 22 23 24 25 26 27 28 29 30 31 
Oct 26 21:08:58 rafale kernel: Sequencer SCB Info: 
Oct 26 21:08:58 rafale kernel:   0
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0x4] 
Oct 26 21:08:58 rafale kernel:   1
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0x7] 
Oct 26 21:08:58 rafale kernel:   2 SCB_CONTROL[0xc0]:(DISCENB|TARGET_SCB) \
                SCB_SCSIID[0x37] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:   3
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0x2] 
Oct 26 21:08:58 rafale kernel:   4 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: SCB_TAG[0xa] 
Oct 26 21:08:58 rafale kernel:   5
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0xb] 
Oct 26 21:08:58 rafale kernel:   6
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0x5] 
Oct 26 21:08:58 rafale kernel:   7
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0x1] 
Oct 26 21:08:58 rafale kernel:   8
SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] SCB_TAG[0x0] 
Oct 26 21:08:58 rafale kernel:   9 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  10 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  11 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  12 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  13 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  14 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  15 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  16 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  17 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  18 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  19 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  20 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  21 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  22 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  23 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  24 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  25 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  26 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  27 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  28 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  29 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  30 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel:  31 SCB_CONTROL[0x0] \
                SCB_SCSIID[0xff]:(TWIN_CHNLB|OID|TWIN_TID) 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0xff]:(SCB_XFERLEN_ODD|LID) SCB_TAG[0xff] 
Oct 26 21:08:58 rafale kernel: Pending list: 
Oct 26 21:08:58 rafale kernel:   3 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:  10 SCB_CONTROL[0x40]:(DISCENB) SCB_SCSIID[0x37] \
                SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   0 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:  11 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   2 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   5 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   4 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   1 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel:   7 SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) \
                SCB_SCSIID[0x7] 
Oct 26 21:08:58 rafale kernel: SCB_LUN[0x0] 
Oct 26 21:08:58 rafale kernel: Kernel Free SCB list: 9 8 
Oct 26 21:08:58 rafale kernel: Untagged Q(3): 10 
Oct 26 21:08:58 rafale kernel: 
Oct 26 21:08:58 rafale kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends \
                >>>>>>>>>>>>>>>>>>
Oct 26 21:08:58 rafale kernel: scsi0:0:3:0: Device is active, asserting ATN
Oct 26 21:08:58 rafale kernel: Recovery code sleeping
Oct 26 21:08:58 rafale kernel: (scsi0:A:3:0): Abort Message Sent
Oct 26 21:08:58 rafale kernel: (scsi0:A:3:0): Recovery SCB completes
Oct 26 21:08:58 rafale kernel: Unexpected busfree in Message-out phase
Oct 26 21:08:58 rafale kernel: SEQADDR == 0x1a8
Oct 26 21:08:58 rafale kernel: Recovery code awake
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x91 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x31 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x19 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0xa2 0xef 0x59 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0xa2 0xef 0x1 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x8a 0x2b 0xa1 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x13 0x24 0x81 0x0 0x0 0x8 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Attempting to queue an ABORT message
Oct 26 21:08:58 rafale kernel: CDB: 0x2a 0x0 0x0 0x8a 0x2b 0xb1 0x0 0x0 0x10 0x0
Oct 26 21:08:58 rafale kernel: scsi0:0:0:0: Command not found
Oct 26 21:08:58 rafale kernel: aic7xxx_abort returns 0x2002
Oct 26 21:08:58 rafale kernel: sr 0:0:3:0: SCSI error: return code = 0x70000

and finish with a panic captured by hands:

SCSI0:0:3:0 Device is active, asserting ATN
Recovery code sleeping
(SCSI0:A:3:0): Abort message sent
(SCSI0:A:3:0): Recovery SCB completes
unexpected busfree in data-out phase
SEQADDR == 0x1a8
Recovery code awake
Kernel panic - not syncing : HOST_MSG_LOOP with invalid SCB ff
Badness in smp_call_function at arc/i386/smp.c:541
[<c01102be>] smp_call_function+0x12e/0x140
[<c011c033>] printk+0x13/0x20
[<c0110923>] smp_send_stop+0x13/0x20
[<c011b799>] panic+0x49/0x100
[<e08a4001>] ahc_handle_seqint+0x1561/0x1570 [aic7xxx]
[<e08b6f2b>] ahc_linux_isr+0x21b/0x260 [aic7xxx]
[<c013d493>] handle_IRQ_event+0x33/0x60
.....

If it could help, log of the scsi detection at boot:

Oct 26 21:16:47 rafale kernel: SCSI subsystem initialized
Oct 26 21:16:47 rafale kernel: scsi0 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA
DRIVER, \
                Rev 7.0
Oct 26 21:16:47 rafale kernel:         <Adaptec 2940 Ultra2 SCSI adapter>
Oct 26 21:16:47 rafale kernel:         aic7890/91: Ultra2 Wide Channel A, SCSI
Id=7, \
                32/253 SCBs
Oct 26 21:16:47 rafale kernel: 
Oct 26 21:16:47 rafale kernel:   Vendor: IBM       Model: DMVS18V           Rev:
02B0
Oct 26 21:16:47 rafale kernel:   Type:   Direct-Access                      ANSI
SCSI \
                revision: 03
Oct 26 21:16:47 rafale kernel: scsi0:A:0:0: Tagged Queuing enabled.  Depth 8
Oct 26 21:16:47 rafale kernel:  target0:0:0: Beginning Domain Validation
Oct 26 21:16:47 rafale kernel:  target0:0:0: wide asynchronous.
Oct 26 21:16:47 rafale kernel:  target0:0:0: FAST-40 WIDE SCSI 80.0 MB/s ST (25
ns, \
                offset 31)
Oct 26 21:16:47 rafale kernel:  target0:0:0: Ending Domain Validation
Oct 26 21:16:47 rafale kernel:   Vendor: YAMAHA    Model: CRW6416S          Rev:
1.0d
Oct 26 21:16:47 rafale kernel:   Type:   CD-ROM                             ANSI
SCSI \
                revision: 02
Oct 26 21:16:47 rafale kernel:  target0:0:3: Beginning Domain Validation
Oct 26 21:16:47 rafale kernel:  target0:0:3: Domain Validation skipping write tests
Oct 26 21:16:47 rafale kernel:  target0:0:3: FAST-10 SCSI 10.0 MB/s ST (100 ns, \
                offset 15)
Oct 26 21:16:47 rafale kernel:  target0:0:3: Ending Domain Validation
Oct 26 21:16:47 rafale kernel:   Vendor: TOSHIBA   Model: CD-ROM XM-3501TA  Rev:
1875
Oct 26 21:16:47 rafale kernel:   Type:   CD-ROM                             ANSI
SCSI \
                revision: 02
Oct 26 21:16:47 rafale kernel:  target0:0:4: Beginning Domain Validation
Oct 26 21:16:47 rafale kernel:  target0:0:4: Domain Validation skipping write tests
Oct 26 21:16:47 rafale kernel:  target0:0:4: Ending Domain Validation
Oct 26 21:16:47 rafale kernel: Attached scsi generic sg0 at scsi0, channel 0, id
0, \
                lun 0,  type 0
Oct 26 21:16:47 rafale kernel: Attached scsi generic sg1 at scsi0, channel 0, id
3, \
                lun 0,  type 5
Oct 26 21:16:47 rafale kernel: Attached scsi generic sg2 at scsi0, channel 0, id
4, \
                lun 0,  type 5
Oct 26 21:16:47 rafale kernel: SCSI device sda: 35843670 512-byte hdwr sectors
(18352 \
                MB)
Oct 26 21:16:47 rafale kernel: SCSI device sda: drive cache: write back
Oct 26 21:16:47 rafale kernel: SCSI device sda: 35843670 512-byte hdwr sectors
(18352 \
                MB)
Oct 26 21:16:47 rafale kernel: SCSI device sda: drive cache: write back
Oct 26 21:16:47 rafale kernel:  sda: sda1 sda2 sda3 sda4
Oct 26 21:16:47 rafale kernel: Attached scsi disk sda at scsi0, channel 0, id 0,
lun \
                0
Oct 26 21:16:47 rafale kernel: sr0: scsi3-mmc drive: 16x/16x writer cd/rw xa/form2 \
                cdda tray
Oct 26 21:16:47 rafale kernel: Uniform CD-ROM driver Revision: 3.20
Oct 26 21:16:47 rafale kernel: Attached scsi CD-ROM sr0 at scsi0, channel 0, id 3, \
                lun 0
Oct 26 21:16:47 rafale kernel: sr1: scsi-1 drive
Oct 26 21:16:47 rafale kernel: Attached scsi CD-ROM sr1 at scsi0, channel 0, id 4, \
lun 0

Thanks.
Emmanuel.
Comment 1 Emmanuel Fust 2006-01-19 01:39:35 UTC 
Created attachment 7070 [details]
Kernel Log
Comment 2 Emmanuel Fust 2006-01-19 01:41:11 UTC 
2.6.15 with James Bottomley "aic7xxx timer handling bug" fix.

It's better !!
The kernel no longuer panic, but the scsi bus never recover.

First, when inserting/ejecting a non-initialised CDRW, I've
got this:
eject:
Jan 12 21:14:26 rafale kernel: sr 0:0:3:0: Attempting to queue
an ABORT message
Jan 12 21:14:26 rafale kernel: CDB: 0x1b 0x0 0x0 0x0 0x2 0x0
Jan 12 21:14:26 rafale kernel: sr 0:0:3:0: Command not found
Jan 12 21:14:26 rafale kernel: aic7xxx_abort returns 0x2002
Jan 12 21:15:17 rafale kernel: Device not ready. Make sure
there is a disc in the drive.
Insert/eject
Jan 12 21:16:31 rafale kernel: sr 0:0:3:0: Attempting to queue
an ABORT message
Jan 12 21:16:31 rafale kernel: CDB: 0x1b 0x0 0x0 0x0 0x2 0x0
Jan 12 21:16:31 rafale kernel: sr 0:0:3:0: Command not found
Jan 12 21:16:31 rafale kernel: aic7xxx_abort returns 0x2002
Insert
Jan 12 21:17:08 rafale kernel: cdrom: This disc doesn't have
any tracks I recognize!
Jan 12 21:17:18 rafale kernel: cdrom: This disc doesn't have
any tracks I recognize!

Next, I tried cdrwtool -d /dev/sr0 -q followed by CTRL-C to
give a chance to the kernel to recover.
I've got tons of errors, but get the shell back.
SCSI bus never really recover, but I've got some syslog trace.
It is big so here as a gziped attachment (with the complete boot
sequence if it could help).

Console trace finish with messages like:

sd 0:0:0:0: SCSI error : return code = 0x6000000
end_request: I/O error, dev sda2, logical block 973373
lost page wite due to I/O error on sda2
...

And it not in the syslog trace indeed ...

Hope this help.

If no one have idea about how to fix this, I will try the
2.6.13 driver (the one before the sync with adaptec if I am
not mistaken, the one which initialise 80% of the cd before
crashing) with only the timer handling bug applied.

One more thing, the eject button of the drive no longuer work
with 2.6.15 (but was with 2.6.14).
Comment 3 Emmanuel Fust 2006-01-19 02:46:25 UTC 
Bug# 5659 is perhaps the same.
There is many repports of pblms with other scsi cards and cd/dvd scsi
readers/writers since 2.6.14/2.6.15 but not with 2.6.13.
I think  I hit two bugs: the timer one, specific of aic7xxx and a more generic
one present since 2.6.14.
Comment 4 Emmanuel Fust 2006-02-01 14:22:09 UTC 
Created attachment 7209 [details]
New kernel log

2.6.15 + James Bottomley "aic7xxx timer handling
bug" fix + "Turn off ordered flush barriers for SCSI driver" + "semaphore to
completion conversion"	from Christoph Hellwig.
Better: I was able to reboot the computer (slooowwwly), but the cdwriter nether
start to initialise the CDRW and the card nether conpletely recover.
Comment 5 Willie Sippel 2006-02-28 05:18:51 UTC 
I don't know if I hit the same bug, but with kernel 2.6.15, my system freezes 
on any CDROM-access. No info in any logfile, can't SSH into the machine, all I 
can do is turn off the computer. This is on x86-64 (Opteron, non-SMP). 
CDROM-access worked perfectly up to 2.6.13, never tested 2.6.14. 
 
I use a Plextor SCSI CDROM and a Pioneer IDE DVD-recorder (with Acard 
IDE->SCSI bridge), both drives, as well as a few SCSI HDDs, connected to an 
Adaptec 19160 controller.
Comment 6 Hamlet Mun 2006-03-29 07:00:10 UTC 
Bug seems to be present in 2.6.14, 2.6.15, 2.6.16, 2.6.16.1
Tested with gentoo-sources - http://dev.gentoo.org/~dsd/genpatches/
Comment 7 Emmanuel Fust 2006-03-29 07:59:23 UTC 
Ok, new patches, no more freeze but doesn't solve my CDRW problem.
Patch 0 - from git tree
Patch 1-5 port of latest aic79xx to aic7xx
Patch 6 correct a bug introduce by patch 1
Comment 8 Emmanuel Fust 2006-03-29 08:00:23 UTC 
Created attachment 7703 [details]
Patch 0
Comment 9 Emmanuel Fust 2006-03-29 08:01:18 UTC 
Created attachment 7704 [details]
Patch 1/5
Comment 10 Emmanuel Fust 2006-03-29 08:02:11 UTC 
Created attachment 7705 [details]
Patch 2/5
Comment 11 Emmanuel Fust 2006-03-29 08:03:02 UTC 
Created attachment 7706 [details]
Patch 3/5
Comment 12 Emmanuel Fust 2006-03-29 08:03:37 UTC 
Created attachment 7707 [details]
Patch 4/5
Comment 13 Emmanuel Fust 2006-03-29 08:04:06 UTC 
Created attachment 7708 [details]
Patch 5/5
Comment 14 Emmanuel Fust 2006-03-29 08:04:44 UTC 
Created attachment 7709 [details]
Patch 6/5
Comment 15 Natalie Protasevich 2007-07-22 17:20:52 UTC 
Any updates on the bug, is it still present in 2.6.22+?
Thanks.
Comment 16 Emmanuel Fust 2007-07-23 13:22:35 UTC 
As of 2.6.21 the bug is still there.
Will try and report results soon with 2.6.22+.
Comment 17 Natalie Protasevich 2008-03-15 11:07:32 UTC 
Ping... how is it working with present kernel?
Comment 18 Emmanuel Fust 2008-03-16 12:44:53 UTC 
(In reply to comment #17)
> Ping... how is it working with present kernel?
> 
Will re-power the affected computer and will try with a 2.6.25-rc5 or newer kernel.
Expect a report in the next 10 days.
Comment 19 Emmanuel Fust 2008-03-30 11:55:04 UTC 
Created attachment 15515 [details]
crash log march 30 2008

I was able to restart cleanly the computer whith the magic Ctrl+Alt+del combo keys, but it took ~1hour.
sr0 is on the narrow bus.
The recovery path still impact non involved devices like sda witch is on the wide bus and wich consequently never fully recover too. 
There is two questions (two bugs too ?)
- why formating a cdrw crash the HBA
- why the recovery code never recover and take sr0 AND sda in a never ending spiral.
Complete log attached.
Comment 20 Emmanuel Fust 2008-09-23 01:16:51 UTC 
Latest tested kernel is 2.6.25
Will retry with 2.6.27.
Note You need to log in before you can comment on or make changes to this bug.