Hi,
[should I post this to fedora-devel instead?]
I'm running 2.6.6-1.435.2.3 on an amanda backup server. During last nights run, I got these[1] messages in my kernel log.
After looking up on google someone else got this because there were too many tags being sent to the drive, but the queue depth[3] is set to one of this drive[4] on this controller [2].
Any idea what caused this?
[1] scsi0:0:2:0: Attempting to queue an ABORT message CDB: 0x1b 0x0 0x0 0x0 0x2 0x0 scsi0: At time of recovery, card was not paused >>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<< scsi0: Dumping Card State while idle, at SEQADDR 0x7 Card was paused ACCUM = 0xad, SINDEX = 0x21, DINDEX = 0x23, ARG_2 = 0x0 HCNT = 0x0 SCBPTR = 0x0 SCSISIGI[0x0] ERROR[0x0] SCSIBUSL[0x0] LASTPHASE[0x1] SCSISEQ[0x12] SBLKCTL[0x2] SCSIRATE[0x0] SEQCTL[0x10] SEQ_FLAGS[0xc0] SSTAT0[0x5] SSTAT1[0xa] SSTAT2[0x0] SSTAT3[0x0] SIMODE0[0x0] SIMODE1[0xa4] SXFRCTL0[0x80] DFCNTRL[0x0] DFSTATUS[0x2d] STACK: 0x0 0x150 0x191 0x3 SCB count = 4 Kernel NEXTQSCB = 2 Card NEXTQSCB = 2 QINFIFO entries: Waiting Queue entries: Disconnected Queue entries: 0:3 QOUTFIFO entries: Sequencer Free SCB List: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 Sequencer SCB Info: 0 SCB_CONTROL[0x44] SCB_SCSIID[0x21] SCB_LUN[0x0] SCB_TAG[0x3] 1 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 2 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 3 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 4 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 5 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 6 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 7 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 8 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 9 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 10 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 11 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 12 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 13 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 14 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 15 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] Pending list: 3 SCB_CONTROL[0x40] SCB_SCSIID[0x21] SCB_LUN[0x0] Kernel Free SCB list: 1 0 Untagged Q(2): 3 DevQ(0:2:0): 0 waiting
<<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>>
(scsi0:A:2:0): Device is disconnected, re-queuing SCB
Recovery code sleeping
(scsi0:A:2:0): Abort Message Sent
(scsi0:A:2:0): SCB 3 - Abort Completed.
Recovery SCB completes
Recovery code awake
aic7xxx_abort returns 0x2002
scsi0:0:2:0: Attempting to queue a TARGET RESET message
CDB: 0x1b 0x0 0x0 0x0 0x2 0x0
scsi0:0:2:0: Is not an active device
aic7xxx_dev_reset returns 0x2002
scsi: Device offlined - not ready after error recovery: host 0 channel 0 id 2 lun 0
scsi0 (2:0): rejecting I/O to offline device
[2]
00:10.0 SCSI storage controller: Adaptec AHA-2940U/UW/D / AIC-7881U (rev 01)
Subsystem: Adaptec AHA-2940UW SCSI Host Adapter
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV+ VGASnoop- ParErr- Stepping- SERR+ FastB2B-
Status: Cap+ 66Mhz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR-
Latency: 64 (2000ns min, 2000ns max), Cache Line Size 08
Interrupt: pin A routed to IRQ 11
Region 0: I/O ports at e800 [disabled] [size=fb000000]
Region 1: Memory at fe000000 (32-bit, non-prefetchable) [size=4K]
Expansion ROM at 00010000 [disabled]
Capabilities: [dc] Power Management version 1
Flags: PMEClk- DSI+ D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot-,D3cold-)
Status: D0 PME-Enable- DSel=0 DScale=0 PME-
[3] cat /proc/scsi/aic7xxx/0 Adaptec AIC7xxx driver version: 6.2.36 Adaptec 2940 Ultra SCSI adapter aic7880: Ultra Wide Channel A, SCSI Id=1, 16/253 SCBs Allocated SCBs: 4, SG List Length: 128
Serial EEPROM: 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x19a6 0x005f 0x2801 0x1010 0xff00 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0x00ff 0x898c
Target 0 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 1 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 2 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Goal: 40.000MB/s transfers (20.000MHz, offset 8, 16bit)
Curr: 3.300MB/s transfers
Channel A Target 2 Lun 0 Settings
Commands Queued 0
Commands Active 0
Command Openings 1
Max Tagged Openings 0
Device Queue Frozen Count 0
Target 3 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 4 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 5 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 6 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 7 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 8 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 9 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 10 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 11 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 12 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 13 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 14 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)
Target 15 Negotiation Settings
User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit)[4] cat /proc/scsi/scsi: Attached devices: Host: scsi0 Channel: 00 Id: 02 Lun: 00 Vendor: SONY Model: SDX-300C Rev: 04b4 Type: Sequential-Access ANSI SCSI revision: 02
[1] scsi0:0:2:0: Attempting to queue an ABORT message CDB: 0x1b 0x0 0x0 0x0 0x2 0x0 scsi0: At time of recovery, card was not paused >>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<< scsi0: Dumping Card State while idle, at SEQADDR 0x7 Card was paused ACCUM = 0xad, SINDEX = 0x21, DINDEX = 0x23, ARG_2 = 0x0 HCNT = 0x0 SCBPTR = 0x0 SCSISIGI[0x0] ERROR[0x0] SCSIBUSL[0x0] LASTPHASE[0x1] SCSISEQ[0x12] SBLKCTL[0x2] SCSIRATE[0x0] SEQCTL[0x10] SEQ_FLAGS[0xc0] SSTAT0[0x5] SSTAT1[0xa] SSTAT2[0x0] SSTAT3[0x0] SIMODE0[0x0] SIMODE1[0xa4] SXFRCTL0[0x80] DFCNTRL[0x0] DFSTATUS[0x2d] STACK: 0x0 0x150 0x191 0x3 SCB count = 4 Kernel NEXTQSCB = 2 Card NEXTQSCB = 2 QINFIFO entries: Waiting Queue entries: Disconnected Queue entries: 0:3 QOUTFIFO entries: Sequencer Free SCB List: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 Sequencer SCB Info: 0 SCB_CONTROL[0x44] SCB_SCSIID[0x21] SCB_LUN[0x0] SCB_TAG[0x3] 1 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 2 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 3 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 4 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 5 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 6 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 7 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 8 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 9 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 10 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 11 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 12 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 13 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 14 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] 15 SCB_CONTROL[0x0] SCB_SCSIID[0xff] SCB_LUN[0xff] SCB_TAG[0xff] Pending list: 3 SCB_CONTROL[0x40] SCB_SCSIID[0x21] SCB_LUN[0x0] Kernel Free SCB list: 1 0 Untagged Q(2): 3 DevQ(0:2:0): 0 waiting <<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>> (scsi0:A:2:0): Device is disconnected, re-queuing SCB Recovery code sleeping (scsi0:A:2:0): Abort Message Sent (scsi0:A:2:0): SCB 3 - Abort Completed. Recovery SCB completes Recovery code awake aic7xxx_abort returns 0x2002 scsi0:0:2:0: Attempting to queue a TARGET RESET message CDB: 0x1b 0x0 0x0 0x0 0x2 0x0 scsi0:0:2:0: Is not an active device aic7xxx_dev_reset returns 0x2002 scsi: Device offlined - not ready after error recovery: host 0 channel 0 id 2 lun 0 scsi0 (2:0): rejecting I/O to offline device [2] 00:10.0 SCSI storage controller: Adaptec AHA-2940U/UW/D / AIC-7881U (rev 01) Subsystem: Adaptec AHA-2940UW SCSI Host Adapter Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV+ VGASnoop- ParErr- Stepping- SERR+ FastB2B- Status: Cap+ 66Mhz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- Latency: 64 (2000ns min, 2000ns max), Cache Line Size 08 Interrupt: pin A routed to IRQ 11 Region 0: I/O ports at e800 [disabled] [size=fb000000] Region 1: Memory at fe000000 (32-bit, non-prefetchable) [size=4K] Expansion ROM at 00010000 [disabled] Capabilities: [dc] Power Management version 1 Flags: PMEClk- DSI+ D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot-,D3cold-) Status: D0 PME-Enable- DSel=0 DScale=0 PME- [3] cat /proc/scsi/aic7xxx/0 Adaptec AIC7xxx driver version: 6.2.36 Adaptec 2940 Ultra SCSI adapter aic7880: Ultra Wide Channel A, SCSI Id=1, 16/253 SCBs Allocated SCBs: 4, SG List Length: 128 Serial EEPROM: 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x02f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x03f8 0x19a6 0x005f 0x2801 0x1010 0xff00 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0x00ff 0x898c Target 0 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 1 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 2 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Goal: 40.000MB/s transfers (20.000MHz, offset 8, 16bit) Curr: 3.300MB/s transfers Channel A Target 2 Lun 0 Settings Commands Queued 0 Commands Active 0 Command Openings 1 Max Tagged Openings 0 Device Queue Frozen Count 0 Target 3 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 4 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 5 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 6 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 7 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 8 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 9 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 10 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 11 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 12 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 13 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 14 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) Target 15 Negotiation Settings User: 40.000MB/s transfers (20.000MHz, offset 127, 16bit) [4] cat /proc/scsi/scsi: Attached devices: Host: scsi0 Channel: 00 Id: 02 Lun: 00 Vendor: SONY Model: SDX-300C Rev: 04b4 Type: Sequential-Access ANSI SCSI revision: 02
