When I came in this evening, I found a bunch of messages referring to
command timeouts. The system seems to have recovered fine this time,
but a few weeks ago I had a situation where I got a bunch of write
errors that somehow propagated to the point of making the entire 4G
drive unusable. What was even weirder was that I got similar errors
when I tried to restore from tape; after doing a hard reformat,
though, things seemed to be fine until tonight. (I'm sorry I don't
have a record of the messages - they got destroyed along with the
rest.)
The one thing I could correlate was that I was trying to copy a lot of
files (~300 megs, several hundred) from one partition to another on
the drive by using a tar pipe. I now have only two partitions on the
drive: data and swap.
Here's the system: Linux 2.0.24, Debian 1.1, Pentium Pro 200 Mhz,
Buslogic BT-958, with the following attached:
Host: scsi0 Channel: 00 Id: 00 Lun: 00
Vendor: MICROP Model: 3243-19 1128RLAV Rev: RLAV
Type: Direct-Access ANSI SCSI revision: 02
Host: scsi0 Channel: 00 Id: 02 Lun: 00
Vendor: TOSHIBA Model: CD-ROM XM-5401TA Rev: 3605
Type: CD-ROM ANSI SCSI revision: 02
Host: scsi0 Channel: 00 Id: 03 Lun: 00
Vendor: HP Model: C1533A Rev: 9503
Type: Sequential-Access ANSI SCSI revision: 02
Host: scsi0 Channel: 00 Id: 04 Lun: 00
Vendor: iomega Model: jaz 1GB Rev: H.71
Type: Direct-Access ANSI SCSI revision: 02
The Jaz drive is external, and is connected by a slightly weird cable
(had to go from a wide SCSI connector to a regular SCSI-2 connector),
but I don't think it is a cabling problem, primarily because my
initial failed restore occured after the Jaz drive was detached. Of
course, I could be wrong.
Whatever the problem is, it is very intermittent. Maybe this is a
hardware/cabling problem; but then again, has anyone else seen
behavior like this?
--Anil
- --
Anil Somayaji (soma@cs.unm.edu)
http://www.cs.unm.edu/~soma
(617)864-0122
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694447, scsi0, channel 0, id 0, lun 0 Write (6) 0f ac 3a 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694463 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694448, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 50 ac 38 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694464 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694449, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 54 6c 4c 00 00 04 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694465 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694450, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 54 6c 52 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694466 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694451, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 58 ec 34 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694467 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694452, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 58 ec 40 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694468 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694453, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 58 ec 78 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694469 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694454, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 58 ee ae 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694470 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694455, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 59 2c 64 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694471 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694456, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 59 6c 6e 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694472 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694457, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 5c 6c 50 00 00 06 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694473 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694458, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 5c 6c 58 00 00 06 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694474 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694459, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 5c ac 4c 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694475 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694460, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 73 6c 50 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694476 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694461, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 79 2c 4e 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694477 to Target 0
Nov 19 19:32:15 snow kernel: scsi : aborting command due to timeout : pid 2694462, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 79 6c 42 00 00 02 00
Nov 19 19:32:15 snow kernel: scsi0: Aborting CCB #2694478 to Target 0
Nov 19 19:32:16 snow kernel: scsi : aborting command due to timeout : pid 2694463, scsi0, channel 0, id 0, lun 0 Write (10) 00 00 79 ec 4a 00 00 02 00
Nov 19 19:32:16 snow kernel: scsi0: Aborting CCB #2694479 to Target 0
Nov 19 19:32:16 snow kernel: scsi : aborting command due to timeout : pid 2694465, scsi0, channel 0, id 0, lun 0 Read (6) 01 f8 10 08 00
Nov 19 19:32:16 snow kernel: scsi0: Aborting CCB #2694481 to Target 0
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694447) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Sending Bus Device Reset CCB #2694492 to Target 0
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694448) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Tagged Queuing now disabled for Target 0
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694449) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694450) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694451) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694452) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694453) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694454) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694455) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694456) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694457) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694458) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694459) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694460) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694461) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694462) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:16 snow kernel: SCSI host 0 abort (pid 2694463) timed out - resetting
Nov 19 19:32:16 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:16 snow kernel: scsi0: Unable to Reset Command to Target 0 - Reset Pending
Nov 19 19:32:17 snow kernel: SCSI host 0 abort (pid 2694465) timed out - resetting
Nov 19 19:32:17 snow kernel: SCSI bus is being reset for host 0 channel 0.
Nov 19 19:32:17 snow kernel: scsi0: Resetting BusLogic BT-958 due to Target 0
Nov 19 19:32:17 snow kernel: scsi0: *** BusLogic BT-958 Initialized Successfully ***
-----BEGIN PGP SIGNATURE-----
Version: 2.6.2
iQCVAwUBMpJrgkLkmkLHxWM5AQFFzwP+LtE74VrIkQm1RLkYj1F5S6n5+m0peXkS
Q6GA13chK8pE+YGde1VZaRymmbWnaIBxNIkpnkCOZDc4qKCvBCb3TE+I6P6oGmMV
Dmf9dYMYXDyjkkQLbwJAjo+tZIO1+8Z8T2QbUvrC8tM/+Wh/tM+IJbsiKfHFuG+5
LCROjwumDwM=
=jat5
-----END PGP SIGNATURE-----