Date: Sat, 17 Jan 2004 13:09:38 -0800 From: Nick Pasich <nick@NickAndBarb.net> To: aic7xxx@freebsd.org Subject: Attempting to queue an ABORT message Message-ID: <20040117210938.GA7738@66.27.62.2>
next in thread | raw e-mail | index | archive | help
I have an adaptec 29160 with 5 drives running on Linux 2.4.24.
I do an rysnc backup from Disk ID:0 to Disk ID:2
and from Disk ID:1 to Disk ID:3 every night.
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: 250, 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 429502
Commands Active 0
Command Openings 253
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 1326067
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 20054
Commands Active 0
Command Openings 64
Max Tagged Openings 253
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 284020
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 433686
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 13873
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:
**************************************************************************
**************************************************************************
Jan 16 23:35:00 NICK2 kernel: kjournald starting. Commit interval 5 seconds
Jan 16 23:35:00 NICK2 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,33), internal journal
Jan 16 23:35:00 NICK2 kernel: EXT3-fs: mounted filesystem with writeback data mode.
Jan 16 23:36:02 NICK2 kernel: scsi0:0:3:0: Attempting to queue an ABORT message
Jan 16 23:36:02 NICK2 kernel: CDB: 0x28 0x0 0x0 0x0 0x0 0x3f 0x0 0x0 0x8 0x0
Jan 16 23:36:02 NICK2 kernel: scsi0: At time of recovery, card was not paused
Jan 16 23:36:02 NICK2 kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<<
Jan 16 23:36:02 NICK2 kernel: scsi0: Dumping Card State while idle, at SEQADDR 0x9
Jan 16 23:36:02 NICK2 kernel: Card was paused
Jan 16 23:36:02 NICK2 kernel: ACCUM = 0x0, SINDEX = 0x4, DINDEX = 0xe4, ARG_2 = 0x0
Jan 16 23:36:02 NICK2 kernel: HCNT = 0x0 SCBPTR = 0x7
Jan 16 23:36:02 NICK2 kernel: SCSIPHASE[0x0] SCSISIGI[0x0] ERROR[0x0] SCSIBUSL[0x0]
Jan 16 23:36:02 NICK2 kernel: LASTPHASE[0x1] SCSISEQ[0x12] SBLKCTL[0xa] SCSIRATE[0x0]
Jan 16 23:36:02 NICK2 kernel: SEQCTL[0x10] SEQ_FLAGS[0xc0] SSTAT0[0x0] SSTAT1[0x8]
Jan 16 23:36:02 NICK2 kernel: SSTAT2[0x0] SSTAT3[0x0] SIMODE0[0x8] SIMODE1[0xa4]
Jan 16 23:36:02 NICK2 kernel: SXFRCTL0[0x80] DFCNTRL[0x0] DFSTATUS[0x89]
Jan 16 23:36:02 NICK2 kernel: STACK: 0xe1 0x163 0x109 0x3
Jan 16 23:36:02 NICK2 kernel: SCB count = 250
Jan 16 23:36:02 NICK2 kernel: Kernel NEXTQSCB = 21
Jan 16 23:36:02 NICK2 kernel: Card NEXTQSCB = 21
Jan 16 23:36:02 NICK2 kernel: QINFIFO entries:
Jan 16 23:36:02 NICK2 kernel: Waiting Queue entries:
Jan 16 23:36:02 NICK2 kernel: Disconnected Queue entries: 22:211
Jan 16 23:36:02 NICK2 kernel: QOUTFIFO entries:
Jan 16 23:36:02 NICK2 kernel: Sequencer Free SCB List: 7 4 30 12 29 1 9 21 24 0 16 23 19 20 11 6 31 8 13 10 5 25 3 26 28 15 18 14 17 2 27
Jan 16 23:36:02 NICK2 kernel: Sequencer SCB Info:
Jan 16 23:36:02 NICK2 kernel: 0 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 1 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 2 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 3 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 4 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 5 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 6 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 7 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 8 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 9 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 10 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 11 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 12 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 13 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 14 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 15 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 16 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 17 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 18 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 19 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 20 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 21 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 22 SCB_CONTROL[0x64] SCB_SCSIID[0x37] SCB_LUN[0x0] SCB_TAG[0xd3]
Jan 16 23:36:02 NICK2 kernel: 23 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 24 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 25 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 26 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 27 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 28 SCB_CONTROL[0xe0] SCB_SCSIID[0x27] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 29 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 30 SCB_CONTROL[0xe0] SCB_SCSIID[0x7] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: 31 SCB_CONTROL[0xe0] SCB_SCSIID[0x17] SCB_LUN[0x0] SCB_TAG[0xff]
Jan 16 23:36:02 NICK2 kernel: Pending list:
Jan 16 23:36:02 NICK2 kernel: 211 SCB_CONTROL[0x60] SCB_SCSIID[0x37] SCB_LUN[0x0]
Jan 16 23:36:02 NICK2 kernel: Kernel Free SCB list: 4 25 247 34 56 124 184 116 232 177 139 80 2 214 196 10 136 204 40 192 134 238 121 180 48 81 241 72 187 76 193 200 28 212 236 145 158 119 37 171 230 131 221 86 226 130 140 7 208 244 89 195 11 148 162 185 127 231 141 52 235 206 79 154 216 133 71 46 54 219 170 189 225 108 182 159 51 32 217 201 172 15 167 165 17 64 203 126 209 191 129 135 149 123 160 224 205 213 125 178 163 143 137 55 176 218 202 183 96 156 234 85 30 249 152 174 61 150 107 115 146 53 161 181 110 142 199 240 8 103 186 13 168 9 227 228 39 164 109 157 239 198 215 68 173 22 229 243 248 242 36 117 210 91 153 1 90 188 63 88 207 197 118 190 220 138 155 16 194 175 19 27 97 223 112 49 50 62 24 132 98 6 147 233 237 144 166 169 179 222 99 26 84 31 70 18 114 66 38 35 23 93 74 59 82 33 3 87 69 14 65 92 100 120 47 104 60 122 106 43 41 44 113 42 12 5 75 67 0 57 111 45 151 102 94 105 128 101 77 95 29 78 58 20 73 83 246 245
Jan 16 23:36:02 NICK2 kernel: DevQ(0:0:0): 0 waiting
Jan 16 23:36:02 NICK2 kernel: DevQ(0:1:0): 0 waiting
Jan 16 23:36:02 NICK2 kernel: DevQ(0:2:0): 0 waiting
Jan 16 23:36:02 NICK2 kernel: DevQ(0:3:0): 0 waiting
Jan 16 23:36:02 NICK2 kernel: DevQ(0:5:0): 0 waiting
Jan 16 23:36:02 NICK2 kernel: DevQ(0:8:0): 0 waiting
Jan 16 23:36:02 NICK2 kernel:
Jan 16 23:36:02 NICK2 kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>>
Jan 16 23:36:02 NICK2 kernel: (scsi0:A:3:0): Device is disconnected, re-queuing SCB
Jan 16 23:36:02 NICK2 kernel: Recovery code sleeping
Jan 16 23:36:02 NICK2 kernel: (scsi0:A:3:0): Abort Tag Message Sent
Jan 16 23:36:02 NICK2 kernel: (scsi0:A:3:0): SCB 211 - Abort Tag Completed.
Jan 16 23:36:02 NICK2 kernel: Recovery SCB completes
Jan 16 23:36:02 NICK2 kernel: Recovery code awake
Jan 16 23:36:02 NICK2 kernel: aic7xxx_abort returns 0x2002
Jan 16 23:36:02 NICK2 kernel: kjournald starting. Commit interval 5 seconds
Jan 16 23:36:02 NICK2 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,49), internal journal
Jan 16 23:36:02 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?20040117210938.GA7738>