Date: Sat, 27 Mar 2004 07:18:31 -0800 From: Nick Pasich <nick@NickAndBarb.net> To: aic7xxx@freebsd.org Subject: Attempting to queue an ABORT message Message-ID: <20040327151831.GA19623@66.27.62.2>
next in thread | raw e-mail | index | archive | help
Hi,
I have an adaptec 29160 with 5 drives running on Linux 2.4.25.
I do an rysnc backup from Disk ID:0 to Disk ID:2
and from Disk ID:1 to Disk ID:3 every morning.
As of late I've been getting "ABORT" messages in the kernel log.
Just wondering what this message is telling me and if the drive
is at fault. The rsync backup always completes without any
problems.
I've attached /proc/scsi, /proc/scsi/aic7xxx/0 and the kernel
logs.
Thanks,
Nick Pasich
/proc/scsi shows:
******************************************************************
******************************************************************
Attached devices:
Host: scsi0 Channel: 00 Id: 00 Lun: 00
Vendor: IBM Model: DDYS-T09170N Rev: S96H
Type: Direct-Access ANSI SCSI revision: 03
Host: scsi0 Channel: 00 Id: 01 Lun: 00
Vendor: IBM Model: DDYS-T09170N Rev: S96H
Type: Direct-Access ANSI SCSI revision: 03
Host: scsi0 Channel: 00 Id: 02 Lun: 00
Vendor: IBM Model: DGHS09U Rev: 03E0
Type: Direct-Access ANSI SCSI revision: 03
Host: scsi0 Channel: 00 Id: 03 Lun: 00
Vendor: IBM Model: DGHS09U Rev: 03E0
Type: Direct-Access ANSI SCSI revision: 03
Host: scsi0 Channel: 00 Id: 05 Lun: 00
Vendor: ARCHIVE Model: Python 04106-XXX Rev: 7600
Type: Sequential-Access ANSI SCSI revision: 02
Host: scsi0 Channel: 00 Id: 08 Lun: 00
Vendor: IBM Model: DGHS09U Rev: 03E0
Type: Direct-Access ANSI SCSI revision: 03
Host: scsi1 Channel: 00 Id: 00 Lun: 00
Vendor: TDK Model: CDRW241040B Rev: 57S5
Type: CD-ROM ANSI SCSI revision: 02
******************************************************************
******************************************************************
/proc/scsi/aic7xxx/0 shows:
******************************************************************
******************************************************************
Adaptec AIC7xxx driver version: 6.2.36
Adaptec 29160 Ultra160 SCSI adapter
aic7892: Ultra160 Wide Channel A, SCSI Id=7, 32/253 SCBs
Allocated SCBs: 230, SG List Length: 102
Serial EEPROM:
0xc33a 0xc33a 0xc33a 0xc33a 0xc33a 0xc33a 0xc33a 0xc33a
0xc33a 0xc33a 0xc33a 0xc33a 0xc33a 0xc33a 0xc33a 0xc33a
0xb8f4 0x745d 0x2807 0x0010 0xffff 0xffff 0xffff 0xffff
0xffff 0xffff 0xffff 0xffff 0xffff 0xffff 0x0250 0x8b4e
Target 0 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Goal: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit)
Curr: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit)
Channel A Target 0 Lun 0 Settings
Commands Queued 1863444
Commands Active 0
Command Openings 128
Max Tagged Openings 253
Device Queue Frozen Count 0
Target 1 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Goal: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit)
Curr: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit)
Channel A Target 1 Lun 0 Settings
Commands Queued 4754643
Commands Active 0
Command Openings 128
Max Tagged Openings 128
Device Queue Frozen Count 0
Target 2 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Goal: 40.000MB/s transfers (20.000MHz, offset 15, 16bit)
Curr: 40.000MB/s transfers (20.000MHz, offset 15, 16bit)
Channel A Target 2 Lun 0 Settings
Commands Queued 75406
Commands Active 0
Command Openings 64
Max Tagged Openings 64
Device Queue Frozen Count 0
Target 3 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Goal: 40.000MB/s transfers (20.000MHz, offset 15, 16bit)
Curr: 40.000MB/s transfers (20.000MHz, offset 15, 16bit)
Channel A Target 3 Lun 0 Settings
Commands Queued 1387547
Commands Active 0
Command Openings 64
Max Tagged Openings 64
Device Queue Frozen Count 0
Target 4 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 5 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Goal: 10.000MB/s transfers (10.000MHz, offset 15)
Curr: 10.000MB/s transfers (10.000MHz, offset 15)
Channel A Target 5 Lun 0 Settings
Commands Queued 2090469
Commands Active 0
Command Openings 1
Max Tagged Openings 0
Device Queue Frozen Count 0
Target 6 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 7 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 8 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Goal: 40.000MB/s transfers (20.000MHz, offset 15, 16bit)
Curr: 40.000MB/s transfers (20.000MHz, offset 15, 16bit)
Channel A Target 8 Lun 0 Settings
Commands Queued 273465
Commands Active 0
Command Openings 64
Max Tagged Openings 253
Device Queue Frozen Count 0
Target 9 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 10 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 11 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 12 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 13 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 14 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
Target 15 Negotiation Settings
User: 160.000MB/s transfers (80.000MHz DT, offset 127, 16bit)
******************************************************************
******************************************************************
kernel log shows:
**************************************************************************
**************************************************************************
Mar 27 03:53:33 NICK2 kernel: kjournald starting. Commit interval 5 seconds
Mar 27 03:53:33 NICK2 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,33), internal journal
Mar 27 03:53:33 NICK2 kernel: EXT3-fs: mounted filesystem with writeback data mode.
Mar 27 03:54:35 NICK2 kernel: scsi0:0:3:0: Attempting to queue an ABORT message
Mar 27 03:54:35 NICK2 kernel: CDB: 0x28 0x0 0x0 0x0 0x0 0x3f 0x0 0x0 0x8 0x0
Mar 27 03:54:35 NICK2 kernel: scsi0: At time of recovery, card was not paused
Mar 27 03:54:35 NICK2 kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<<
Mar 27 03:54:35 NICK2 kernel: scsi0: Dumping Card State while idle, at SEQADDR 0x8
Mar 27 03:54:35 NICK2 kernel: Card was paused
Mar 27 03:54:35 NICK2 kernel: ACCUM = 0x0, SINDEX = 0x19, DINDEX = 0xe4, ARG_2 = 0x0
Mar 27 03:54:35 NICK2 kernel: HCNT = 0x0 SCBPTR = 0x1
Mar 27 03:54:35 NICK2 kernel: SCSIPHASE[0x0] SCSISIGI[0x0] ERROR[0x0] SCSIBUSL[0x0]
Mar 27 03:54:35 NICK2 kernel: LASTPHASE[0x1] SCSISEQ[0x12] SBLKCTL[0xa] SCSIRATE[0x0]
Mar 27 03:54:35 NICK2 kernel: SEQCTL[0x10] SEQ_FLAGS[0xc0] SSTAT0[0x0] SSTAT1[0x8]
Mar 27 03:54:35 NICK2 kernel: SSTAT2[0x0] SSTAT3[0x0] SIMODE0[0x8] SIMODE1[0xa4]
Mar 27 03:54:35 NICK2 kernel: SXFRCTL0[0x80] DFCNTRL[0x0] DFSTATUS[0x89]
Mar 27 03:54:35 NICK2 kernel: STACK: 0xe1 0x163 0x109 0x3
Mar 27 03:54:35 NICK2 kernel: SCB count = 230
Mar 27 03:54:35 NICK2 kernel: Kernel NEXTQSCB = 29
Mar 27 03:54:35 NICK2 kernel: Card NEXTQSCB = 29
Mar 27 03:54:35 NICK2 kernel: QINFIFO entries:
Mar 27 03:54:35 NICK2 kernel: Waiting Queue entries:
Mar 27 03:54:35 NICK2 kernel: Disconnected Queue entries: 29:147
Mar 27 03:54:35 NICK2 kernel: QOUTFIFO entries:
Mar 27 03:54:35 NICK2 kernel: Sequencer Free SCB List: 1 5 12 20 24 2 10 26 31 13 23 19 27 6 22 8 30 15 9 14 7 4 0 3 17 21 28 25 18 11 16
Mar 27 03:54:35 NICK2 kernel: Sequencer SCB Info:
Mar 27 03:54:35 NICK2 kernel: 0 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 1 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 2 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 3 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 4 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 5 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 6 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 7 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 8 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 9 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 10 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 11 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 12 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 13 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 14 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 15 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 16 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 17 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 18 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 19 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 20 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 21 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 22 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 23 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 24 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 25 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 26 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 27 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 28 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 29 SCB_CONTROL[0x64] SCB_SCSIID[0x37] SCB_LUN[0x0] SCB_TAG[0x93]
Mar 27 03:54:35 NICK2 kernel: 30 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: 31 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Mar 27 03:54:35 NICK2 kernel: Pending list:
Mar 27 03:54:35 NICK2 kernel: 147 SCB_CONTROL[0x60] SCB_SCSIID[0x37] SCB_LUN[0x0]
Mar 27 03:54:35 NICK2 kernel: Kernel Free SCB list: 25 2 200 85 53 102 153 155 101 95 152 20 47 46 99 59 114 188 128 160 75 18 26 52 84 22 208 103 142 190 88 42 62 7 220 86 108 15 123 45 218 120 150 185 126 180 189 93 192 141 109 32 197 92 96 5 69 64 100 228 82 158 78 107 127 83 137 81 178 214 193 0 111 1 34 13 223 207 131 168 67 196 151 139 60 105 174 9 72 121 17 110 16 161 41 146 156 31 116 201 117 35 222 167 55 179 56 14 144 19 36 54 176 229 66 143 90 204 184 186 48 163 209 210 198 206 40 164 50 135 182 89 94 202 51 125 63 118 68 177 28 221 49 194 175 124 159 91 24 74 191 199 38 213 37 39 140 71 106 87 79 187 23 21 3 154 80 133 169 215 30 173 165 73 166 97 212 70 157 57 115 11 162 113 130 77 58 181 122 183 171 76 172 112 27 205 104 44 145 65 61 216 148 4 43 12 119 132 224 211 6 10 33 203 136 149 138 217 195 134 170 8 98 219 129 227 226 225
Mar 27 03:54:35 NICK2 kernel: DevQ(0:0:0): 0 waiting
Mar 27 03:54:35 NICK2 kernel: DevQ(0:1:0): 0 waiting
Mar 27 03:54:35 NICK2 kernel: DevQ(0:2:0): 0 waiting
Mar 27 03:54:35 NICK2 kernel: DevQ(0:3:0): 0 waiting
Mar 27 03:54:35 NICK2 kernel: DevQ(0:5:0): 0 waiting
Mar 27 03:54:35 NICK2 kernel: DevQ(0:8:0): 0 waiting
Mar 27 03:54:35 NICK2 kernel:
Mar 27 03:54:35 NICK2 kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>>
Mar 27 03:54:35 NICK2 kernel: (scsi0:A:3:0): Device is disconnected, re-queuing SCB
Mar 27 03:54:35 NICK2 kernel: Recovery code sleeping
Mar 27 03:54:35 NICK2 kernel: (scsi0:A:3:0): Abort Tag Message Sent
Mar 27 03:54:35 NICK2 kernel: (scsi0:A:3:0): SCB 147 - Abort Tag Completed.
Mar 27 03:54:35 NICK2 kernel: Recovery SCB completes
Mar 27 03:54:35 NICK2 kernel: Recovery code awake
Mar 27 03:54:35 NICK2 kernel: aic7xxx_abort returns 0x2002
Mar 27 03:54:35 NICK2 kernel: kjournald starting. Commit interval 5 seconds
Mar 27 03:54:35 NICK2 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,49), internal journal
Mar 27 03:54:35 NICK2 kernel: EXT3-fs: mounted filesystem with writeback data mode.
**************************************************************************
**************************************************************************
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20040327151831.GA19623>