Date: Mon, 09 Jun 1997 21:16:39 +0200 From: Tor Egge <Tor.Egge@idi.ntnu.no> To: freebsd-scsi@freebsd.org Subject: scsi recovery code causes system freeze Message-ID: <199706091916.VAA16067@pat.idi.ntnu.no>
next in thread | raw e-mail | index | archive | help
----Next_Part(Mon_Jun__9_21:12:56_1997)--
Content-Type: Text/Plain; charset=us-ascii
Content-Transfer-Encoding: 7bit
I have some problems with heavy write activity on a scsi bus causing
scsi timeouts. Sometimes the machine freezes during the error
recovery.
I have reproduced the timeout problems on two machines:
ikke.idi.ntnu.no:
5 external disks of type <Quantum XP34300W L915>,
all located in a single external enclosure.
AHA 2940UW controller, < 3 m scsi cable.
DDB configured.
skarven.itea.ntnu.no:
7 external disks of type <QUANTUM XP34550W LXY4>,
1 external disks of type <QUANTUM XP34550W LXY1>,
located in two external enclosures (4 disks in each).
AHA 2940UW controller, < 3 m scsi cable.
DDB not configured, since the machine should be
able to boot after a trap 12.
The timeout problem only seem to happen during periods with intense
write activity on multiple disks on the same scsi bus.
For both machines, the number of openings on drives supporting tagged
commands has been reduced from 8 to 4. This does not help. :-(
The freeze problem has currently only occured on skarven.itea.ntnu.no.
In all freezes, the messages file has ended in ``Clearing bus reset'',
with no following ``Clearing 'in-reset' flag''. This indicates a
serious problem with the SCSI bus reset code.
The /var/log/messages file is accessed via a different SCSI controller,
thus I suspect the timeout is never occuring for some reason.
One possible scenario is:
- Bus reset cleared, bus reset settle timeout scheduled
- New scsi command to a target on the same scsi bus arrives
before the bus reset settle timeout has been triggered.
- Infinite retry loop in scsi_scsi_cmd blocking the bus reset
settle timeout:
- scsi_scsi_cmd calls ahc_scsi_cmd, which
sets xs->error to XS_BUSY, increases the
retry count and returns immediately
with the value COMPLETE.
- scsi_scsi_cmd then calls sc_err1, which delays 1 ms,
decreases the retry count by one, and returns the
value SCSIRET_DO_RETRY.
This causes scsi_scsi_cmd to never actually finish, since
the timeout to remove the bus reset is blocked by the
retry loop.
This also causes the system to freeze.
- Tor Egge
----Next_Part(Mon_Jun__9_21:12:56_1997)--
Content-Type: Text/Plain; charset=us-ascii
Content-Transfer-Encoding: 7bit
Content-Description: "cut from the messages file"
Jun 5 21:32:00 skarven /kernel: sd7: SCB 0x1c - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:32:00 skarven /kernel: SEQADDR = 0x9 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:32:00 skarven /kernel: Ordered Tag queued
Jun 5 21:32:00 skarven /kernel: sd12: SCB 0x8 timedout while recovery in progress
Jun 5 21:32:00 skarven /kernel: Ordered Tag sent
Jun 5 21:32:05 skarven /kernel: sd7: SCB 0x1c - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:32:05 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:32:05 skarven /kernel: sd7: Queueing an Abort SCB
Jun 5 21:32:05 skarven /kernel: sd7: Abort Message Sent
Jun 5 21:32:05 skarven /kernel: sd7: SCB 28 - Abort Tag Completed.
Jun 5 21:32:05 skarven /kernel: sd7: no longer in timeout
Jun 5 21:32:10 skarven /kernel: sd12: SCB 0x8 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:32:10 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x27 SSTAT1 = 0xb
Jun 5 21:32:10 skarven /kernel: Ordered Tag queued
Jun 5 21:32:10 skarven /kernel: Ordered Tag sent
Jun 5 21:32:15 skarven /kernel: sd12: SCB 0x8 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:32:15 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:32:15 skarven /kernel: sd12: Queueing an Abort SCB
Jun 5 21:32:15 skarven /kernel: sd12: Abort Message Sent
Jun 5 21:32:15 skarven /kernel: sd12: SCB 8 - Abort Tag Completed.
Jun 5 21:32:15 skarven /kernel: sd12: no longer in timeout
Jun 5 21:34:59 skarven ftpd[19495]: FTP LOGIN FAILED FROM inetgw.guidant.com, dir
Jun 5 21:49:42 skarven /kernel: sd11: SCB 0x2 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:49:42 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:49:42 skarven /kernel: Ordered Tag queued
Jun 5 21:49:42 skarven /kernel: sd12: SCB 0xf timedout while recovery in progress
Jun 5 21:49:42 skarven /kernel: sd12: SCB 0xe timedout while recovery in progress
Jun 5 21:49:42 skarven /kernel: sd13: SCB 0xb timedout while recovery in progress
Jun 5 21:49:42 skarven /kernel: sd13: SCB 0x12 timedout while recovery in progress
Jun 5 21:49:47 skarven /kernel: sd11: SCB 0x2 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:49:47 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:49:47 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:49:47 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:49:47 skarven /kernel: sd11: SCB 2 - Abort Tag Completed.
Jun 5 21:49:47 skarven /kernel: sd11: no longer in timeout
Jun 5 21:49:47 skarven /kernel: Ordered Tag sent
Jun 5 21:49:52 skarven /kernel: sd13: SCB 0x12 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:49:52 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:49:52 skarven /kernel: Ordered Tag queued
Jun 5 21:49:52 skarven /kernel: sd13: SCB 0xb timedout while recovery in progress
Jun 5 21:49:52 skarven /kernel: sd12: SCB 0xe timedout while recovery in progress
Jun 5 21:49:52 skarven /kernel: sd12: SCB 0xf timedout while recovery in progress
Jun 5 21:49:57 skarven /kernel: sd13: SCB 0x12 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:49:57 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:49:57 skarven /kernel: sd13: Queueing an Abort SCB
Jun 5 21:49:57 skarven /kernel: sd13: Abort Message Sent
Jun 5 21:49:57 skarven /kernel: sd13: SCB 18 - Abort Tag Completed.
Jun 5 21:49:57 skarven /kernel: sd13: no longer in timeout
Jun 5 21:49:57 skarven /kernel: Ordered Tag sent
Jun 5 21:50:02 skarven /kernel: sd12: SCB 0xf - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:50:02 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:50:02 skarven /kernel: Ordered Tag queued
Jun 5 21:50:02 skarven /kernel: sd12: SCB 0xe timedout while recovery in progress
Jun 5 21:50:02 skarven /kernel: sd13: SCB 0xb timedout while recovery in progress
Jun 5 21:50:02 skarven /kernel: Ordered Tag sent
Jun 5 21:50:07 skarven /kernel: sd12: SCB 0xf - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:50:07 skarven /kernel: SEQADDR = 0x9 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:50:07 skarven /kernel: sd12: Queueing an Abort SCB
Jun 5 21:50:07 skarven /kernel: sd12: Abort Message Sent
Jun 5 21:50:07 skarven /kernel: sd12: SCB 15 - Abort Tag Completed.
Jun 5 21:50:07 skarven /kernel: sd12: no longer in timeout
Jun 5 21:50:12 skarven /kernel: sd13: SCB 0xb - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:50:12 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:50:12 skarven /kernel: Ordered Tag queued
Jun 5 21:50:12 skarven /kernel: sd12: SCB 0xe timedout while recovery in progress
Jun 5 21:50:12 skarven /kernel: Ordered Tag sent
Jun 5 21:50:17 skarven /kernel: sd13: SCB 0xb - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:50:17 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:50:17 skarven /kernel: sd13: Queueing an Abort SCB
Jun 5 21:50:17 skarven /kernel: sd13: Abort Message Sent
Jun 5 21:50:17 skarven /kernel: sd13: SCB 11 - Abort Tag Completed.
Jun 5 21:50:17 skarven /kernel: sd13: no longer in timeout
Jun 5 21:50:22 skarven /kernel: sd12: SCB 0xe - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:50:22 skarven /kernel: SEQADDR = 0x9 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:50:22 skarven /kernel: Ordered Tag queued
Jun 5 21:50:22 skarven /kernel: Ordered Tag sent
Jun 5 21:50:27 skarven /kernel: sd12: SCB 0xe - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:50:27 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:50:27 skarven /kernel: sd12: Queueing an Abort SCB
Jun 5 21:50:27 skarven /kernel: sd12: Abort Message Sent
Jun 5 21:50:27 skarven /kernel: sd12: SCB 14 - Abort Tag Completed.
Jun 5 21:50:27 skarven /kernel: sd12: no longer in timeout
Jun 5 21:52:47 skarven /kernel: sd11: SCB 0x3 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:52:47 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:52:47 skarven /kernel: Ordered Tag queued
Jun 5 21:52:47 skarven /kernel: sd11: SCB 0xe timedout while recovery in progress
Jun 5 21:52:47 skarven /kernel: sd12: SCB 0x19 timedout while recovery in progress
Jun 5 21:52:52 skarven /kernel: sd11: SCB 0x3 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:52:52 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:52:52 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:52:52 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:52:52 skarven /kernel: sd11: SCB 3 - Abort Tag Completed.
Jun 5 21:52:52 skarven /kernel: sd11: no longer in timeout
Jun 5 21:52:52 skarven /kernel: Ordered Tag sent
Jun 5 21:52:57 skarven /kernel: sd12: SCB 0x19 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:52:57 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:52:57 skarven /kernel: Ordered Tag queued
Jun 5 21:52:57 skarven /kernel: sd11: SCB 0xe timedout while recovery in progress
Jun 5 21:53:02 skarven /kernel: sd12: SCB 0x19 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:53:02 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:53:02 skarven /kernel: sd12: Queueing an Abort SCB
Jun 5 21:53:02 skarven /kernel: sd12: Abort Message Sent
Jun 5 21:53:02 skarven /kernel: sd12: SCB 25 - Abort Tag Completed.
Jun 5 21:53:02 skarven /kernel: sd12: no longer in timeout
Jun 5 21:53:02 skarven /kernel: Ordered Tag sent
Jun 5 21:53:07 skarven /kernel: sd11: SCB 0xe - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:53:07 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:53:07 skarven /kernel: Ordered Tag queued
Jun 5 21:53:07 skarven /kernel: Ordered Tag sent
Jun 5 21:53:12 skarven /kernel: sd11: SCB 0xe - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:53:12 skarven /kernel: SEQADDR = 0x9 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:53:12 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:53:12 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:53:12 skarven /kernel: sd11: SCB 14 - Abort Tag Completed.
Jun 5 21:53:12 skarven /kernel: sd11: no longer in timeout
Jun 5 21:55:48 skarven ftpd[19613]: warning: can't verify hostname: gethostbyname(ppp3-cst100.warszawa.tpnet.pl) failed
Jun 5 21:55:48 skarven ftpd[19613]: refused connect from 195.116.251.100
Jun 5 21:55:58 skarven /kernel: sd13: SCB 0x1b - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:55:58 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:55:58 skarven /kernel: Ordered Tag queued
Jun 5 21:55:58 skarven /kernel: sd11: SCB 0x12 timedout while recovery in progress
Jun 5 21:55:58 skarven /kernel: sd11: SCB 0x9 timedout while recovery in progress
Jun 5 21:55:58 skarven /kernel: sd11: SCB 0xd timedout while recovery in progress
Jun 5 21:55:58 skarven /kernel: sd11: SCB 0x13 timedout while recovery in progress
Jun 5 21:55:58 skarven /kernel: sd7: SCB 0x2 timedout while recovery in progress
Jun 5 21:56:03 skarven /kernel: sd13: SCB 0x1b - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:03 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:03 skarven /kernel: sd13: Queueing an Abort SCB
Jun 5 21:56:03 skarven /kernel: sd13: Abort Message Sent
Jun 5 21:56:03 skarven /kernel: sd13: SCB 27 - Abort Tag Completed.
Jun 5 21:56:03 skarven /kernel: sd13: no longer in timeout
Jun 5 21:56:03 skarven /kernel: Ordered Tag sent
Jun 5 21:56:08 skarven /kernel: sd11: SCB 0x13 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:08 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:08 skarven /kernel: Ordered Tag queued
Jun 5 21:56:08 skarven /kernel: sd11: SCB 0xd timedout while recovery in progress
Jun 5 21:56:08 skarven /kernel: sd11: SCB 0x9 timedout while recovery in progress
Jun 5 21:56:08 skarven /kernel: sd11: SCB 0x12 timedout while recovery in progress
Jun 5 21:56:08 skarven /kernel: sd7: SCB 0x2 timedout while recovery in progress
Jun 5 21:56:13 skarven /kernel: sd11: SCB 0x13 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:13 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:13 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:56:13 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:56:13 skarven /kernel: sd11: SCB 19 - Abort Tag Completed.
Jun 5 21:56:13 skarven /kernel: sd11: no longer in timeout
Jun 5 21:56:13 skarven /kernel: Ordered Tag sent
Jun 5 21:56:18 skarven /kernel: sd11: SCB 0x12 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:18 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:18 skarven /kernel: Ordered Tag queued
Jun 5 21:56:18 skarven /kernel: sd11: SCB 0x9 timedout while recovery in progress
Jun 5 21:56:18 skarven /kernel: sd11: SCB 0xd timedout while recovery in progress
Jun 5 21:56:18 skarven /kernel: sd7: SCB 0x2 timedout while recovery in progress
Jun 5 21:56:18 skarven /kernel: Ordered Tag sent
Jun 5 21:56:23 skarven /kernel: sd11: SCB 0x12 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:23 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:23 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:56:23 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:56:23 skarven /kernel: sd11: SCB 18 - Abort Tag Completed.
Jun 5 21:56:23 skarven /kernel: sd11: no longer in timeout
Jun 5 21:56:25 skarven xntpd[109]: time reset (step) 1.406288 s
Jun 5 21:56:30 skarven /kernel: sd11: SCB 0xd - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:30 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:30 skarven /kernel: Ordered Tag queued
Jun 5 21:56:30 skarven /kernel: sd11: SCB 0x9 timedout while recovery in progress
Jun 5 21:56:30 skarven /kernel: sd7: SCB 0x2 timedout while recovery in progress
Jun 5 21:56:30 skarven /kernel: Ordered Tag sent
Jun 5 21:56:35 skarven /kernel: sd11: SCB 0xd - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:35 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:35 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:56:35 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:56:35 skarven /kernel: sd11: SCB 13 - Abort Tag Completed.
Jun 5 21:56:35 skarven /kernel: sd11: no longer in timeout
Jun 5 21:56:40 skarven /kernel: sd11: SCB 0x9 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:40 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:40 skarven /kernel: Ordered Tag queued
Jun 5 21:56:40 skarven /kernel: sd7: SCB 0x2 timedout while recovery in progress
Jun 5 21:56:40 skarven /kernel: Ordered Tag sent
Jun 5 21:56:45 skarven /kernel: sd11: SCB 0x9 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:45 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:45 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 21:56:45 skarven /kernel: sd11: Abort Message Sent
Jun 5 21:56:45 skarven /kernel: sd11: SCB 9 - Abort Tag Completed.
Jun 5 21:56:45 skarven /kernel: sd11: no longer in timeout
Jun 5 21:56:50 skarven /kernel: sd7: SCB 0x2 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:50 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x27 SSTAT1 = 0xb
Jun 5 21:56:50 skarven /kernel: Ordered Tag queued
Jun 5 21:56:50 skarven /kernel: Ordered Tag sent
Jun 5 21:56:55 skarven /kernel: sd7: SCB 0x2 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:56:55 skarven /kernel: SEQADDR = 0x9 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:56:55 skarven /kernel: sd7: Queueing an Abort SCB
Jun 5 21:56:55 skarven /kernel: sd7: Abort Message Sent
Jun 5 21:56:55 skarven /kernel: sd7: SCB 2 - Abort Tag Completed.
Jun 5 21:56:55 skarven /kernel: sd7: no longer in timeout
Jun 5 21:57:36 skarven /kernel: sd6: SCB 0xd - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:57:36 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:57:36 skarven /kernel: Ordered Tag queued
Jun 5 21:57:41 skarven /kernel: sd6: SCB 0xd - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 21:57:41 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 21:57:41 skarven /kernel: sd6: Queueing an Abort SCB
Jun 5 21:57:41 skarven /kernel: sd6: Abort Message Sent
Jun 5 21:57:41 skarven /kernel: sd6: SCB 13 - Abort Tag Completed.
Jun 5 21:57:41 skarven /kernel: sd6: no longer in timeout
Jun 5 21:57:41 skarven /kernel: Ordered Tag sent
Jun 5 22:01:12 skarven /kernel: sd12: SCB 0x7 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:12 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:12 skarven /kernel: Ordered Tag queued
Jun 5 22:01:12 skarven /kernel: sd13: SCB 0xa timedout while recovery in progress
Jun 5 22:01:12 skarven /kernel: sd11: SCB 0x10 timedout while recovery in progress
Jun 5 22:01:12 skarven /kernel: sd13: SCB 0xd timedout while recovery in progress
Jun 5 22:01:12 skarven /kernel: sd13: SCB 0x0 timedout while recovery in progress
Jun 5 22:01:17 skarven /kernel: sd12: SCB 0x7 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:17 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:17 skarven /kernel: sd12: Queueing an Abort SCB
Jun 5 22:01:17 skarven /kernel: sd12: Abort Message Sent
Jun 5 22:01:17 skarven /kernel: sd12: SCB 7 - Abort Tag Completed.
Jun 5 22:01:17 skarven /kernel: sd12: no longer in timeout
Jun 5 22:01:17 skarven /kernel: Ordered Tag sent
Jun 5 22:01:22 skarven /kernel: sd13: SCB 0x0 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:22 skarven /kernel: SEQADDR = 0x9 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:22 skarven /kernel: Ordered Tag queued
Jun 5 22:01:22 skarven /kernel: sd13: SCB 0xd timedout while recovery in progress
Jun 5 22:01:22 skarven /kernel: sd11: SCB 0x10 timedout while recovery in progress
Jun 5 22:01:22 skarven /kernel: sd13: SCB 0xa timedout while recovery in progress
Jun 5 22:01:27 skarven /kernel: sd13: SCB 0x0 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:27 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:27 skarven /kernel: sd13: Queueing an Abort SCB
Jun 5 22:01:27 skarven /kernel: sd13: Abort Message Sent
Jun 5 22:01:27 skarven /kernel: sd13: SCB 0 - Abort Tag Completed.
Jun 5 22:01:27 skarven /kernel: sd13: no longer in timeout
Jun 5 22:01:27 skarven /kernel: Ordered Tag sent
Jun 5 22:01:32 skarven /kernel: sd13: SCB 0xa - timed out in command phase, SCSISIGI == 0xe6
Jun 5 22:01:32 skarven /kernel: SEQADDR = 0x4f SCSISEQ = 0x12 SSTAT0 = 0x7 SSTAT1 = 0x13
Jun 5 22:01:32 skarven /kernel: Ordered Tag queued
Jun 5 22:01:32 skarven /kernel: sd11: SCB 0x10 timedout while recovery in progress
Jun 5 22:01:32 skarven /kernel: sd13: SCB 0xd timedout while recovery in progress
Jun 5 22:01:32 skarven /kernel: Ordered Tag sent
Jun 5 22:01:37 skarven /kernel: sd13: SCB 0xa - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:37 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:37 skarven /kernel: sd13: Queueing an Abort SCB
Jun 5 22:01:37 skarven /kernel: sd13: Abort Message Sent
Jun 5 22:01:37 skarven /kernel: sd13: SCB 10 - Abort Tag Completed.
Jun 5 22:01:37 skarven /kernel: sd13: no longer in timeout
Jun 5 22:01:42 skarven /kernel: sd13: SCB 0xd - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:42 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:42 skarven /kernel: Ordered Tag queued
Jun 5 22:01:42 skarven /kernel: sd11: SCB 0x10 timedout while recovery in progress
Jun 5 22:01:42 skarven /kernel: Ordered Tag sent
Jun 5 22:01:47 skarven /kernel: sd13: SCB 0xd - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:47 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:47 skarven /kernel: sd13: Queueing an Abort SCB
Jun 5 22:01:47 skarven /kernel: sd13: Abort Message Sent
Jun 5 22:01:47 skarven /kernel: sd13: SCB 13 - Abort Tag Completed.
Jun 5 22:01:47 skarven /kernel: sd13: no longer in timeout
Jun 5 22:01:52 skarven /kernel: sd11: SCB 0x10 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:01:52 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:01:52 skarven /kernel: Ordered Tag queued
Jun 5 22:01:52 skarven /kernel: Ordered Tag sent
Jun 5 22:01:57 skarven /kernel: sd11: SCB 0x10 - timed out in command phase, SCSISIGI == 0xe6
Jun 5 22:01:57 skarven /kernel: SEQADDR = 0x4f SCSISEQ = 0x12 SSTAT0 = 0x7 SSTAT1 = 0x13
Jun 5 22:01:57 skarven /kernel: sd6: abort message in message buffer
Jun 5 22:01:57 skarven /kernel: ahc1:A:2: Missed busfree.
Jun 5 22:01:57 skarven /kernel: sd6: SCB 0x13 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0xb6
Jun 5 22:01:57 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x5a SSTAT0 = 0x7 SSTAT1 = 0x13
Jun 5 22:01:57 skarven /kernel: ahc1: Issued Channel A Bus Reset. 5 SCBs aborted
Jun 5 22:01:57 skarven /kernel: Clearing bus reset
Jun 5 22:01:58 skarven /kernel: Clearing 'in-reset' flag
Jun 5 22:01:58 skarven /kernel: sd11: no longer in timeout
Jun 5 22:01:58 skarven /kernel: sd6: no longer in timeout
Jun 5 22:01:58 skarven /kernel: sd8: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:3
Jun 5 22:01:58 skarven /kernel: sd6: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:3
Jun 5 22:01:58 skarven /kernel: sd11: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:3
Jun 5 22:01:58 skarven /kernel: sd7: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:3
Jun 5 22:01:58 skarven /kernel: sd10: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:4
Jun 5 22:01:58 skarven /kernel: sd9: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:4
Jun 5 22:01:58 skarven /kernel: sd12: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:4
Jun 5 22:01:58 skarven /kernel: sd13: UNIT ATTENTION asc:29,2
Jun 5 22:01:58 skarven /kernel: , retries:4
Jun 5 22:04:18 skarven /kernel: sd11: SCB 0x2 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:18 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x27 SSTAT1 = 0xb
Jun 5 22:04:18 skarven /kernel: Ordered Tag queued
Jun 5 22:04:18 skarven /kernel: sd11: SCB 0x0 timedout while recovery in progress
Jun 5 22:04:18 skarven /kernel: sd11: SCB 0x15 timedout while recovery in progress
Jun 5 22:04:18 skarven /kernel: sd11: SCB 0x5 timedout while recovery in progress
Jun 5 22:04:23 skarven /kernel: sd11: SCB 0x2 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:23 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:04:23 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 22:04:23 skarven /kernel: sd11: Abort Message Sent
Jun 5 22:04:23 skarven /kernel: sd11: SCB 2 - Abort Tag Completed.
Jun 5 22:04:23 skarven /kernel: sd11: no longer in timeout
Jun 5 22:04:23 skarven /kernel: Ordered Tag sent
Jun 5 22:04:28 skarven /kernel: sd11: SCB 0x0 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:28 skarven /kernel: SEQADDR = 0x8 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:04:28 skarven /kernel: Ordered Tag queued
Jun 5 22:04:28 skarven /kernel: sd11: SCB 0x5 timedout while recovery in progress
Jun 5 22:04:28 skarven /kernel: sd11: SCB 0x15 timedout while recovery in progress
Jun 5 22:04:28 skarven /kernel: Ordered Tag sent
Jun 5 22:04:33 skarven /kernel: sd11: SCB 0x0 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:33 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:04:33 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 22:04:33 skarven /kernel: sd11: Abort Message Sent
Jun 5 22:04:33 skarven /kernel: sd11: SCB 0 - Abort Tag Completed.
Jun 5 22:04:33 skarven /kernel: sd11: no longer in timeout
Jun 5 22:04:38 skarven /kernel: sd11: SCB 0x15 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:38 skarven /kernel: SEQADDR = 0x6 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:04:38 skarven /kernel: Ordered Tag queued
Jun 5 22:04:38 skarven /kernel: sd11: SCB 0x5 timedout while recovery in progress
Jun 5 22:04:38 skarven /kernel: Ordered Tag sent
Jun 5 22:04:43 skarven /kernel: sd11: SCB 0x15 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:43 skarven /kernel: SEQADDR = 0x7 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:04:43 skarven /kernel: sd11: Queueing an Abort SCB
Jun 5 22:04:43 skarven /kernel: sd11: Abort Message Sent
Jun 5 22:04:43 skarven /kernel: sd11: SCB 21 - Abort Tag Completed.
Jun 5 22:04:43 skarven /kernel: sd11: no longer in timeout
Jun 5 22:04:48 skarven /kernel: sd11: SCB 0x5 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0x0
Jun 5 22:04:48 skarven /kernel: SEQADDR = 0x4 SCSISEQ = 0x12 SSTAT0 = 0x5 SSTAT1 = 0xa
Jun 5 22:04:48 skarven /kernel: Ordered Tag queued
Jun 5 22:04:48 skarven /kernel: Ordered Tag sent
Jun 5 22:04:53 skarven /kernel: sd11: SCB 0x5 - timed out in command phase, SCSISIGI == 0xe6
Jun 5 22:04:53 skarven /kernel: SEQADDR = 0x4f SCSISEQ = 0x12 SSTAT0 = 0x7 SSTAT1 = 0x13
Jun 5 22:04:53 skarven /kernel: sd6: abort message in message buffer
Jun 5 22:04:53 skarven /kernel: ahc1:A:2: Missed busfree.
Jun 5 22:04:53 skarven /kernel: sd6: SCB 0x0 - timed out while idle, LASTPHASE == 0x1, SCSISIGI == 0xb6
Jun 5 22:04:53 skarven /kernel: SEQADDR = 0x5 SCSISEQ = 0x5a SSTAT0 = 0x7 SSTAT1 = 0x13
Jun 5 22:04:53 skarven /kernel: ahc1: Issued Channel A Bus Reset. 7 SCBs aborted
Jun 5 22:04:53 skarven /kernel: Clearing bus reset
----Next_Part(Mon_Jun__9_21:12:56_1997)--
Content-Type: Text/Plain; charset=us-ascii
Content-Transfer-Encoding: 7bit
Content-Description: "scsi driver patch"
Index: aic7xxx.c
===================================================================
RCS file: /home/ncvs/src/sys/i386/scsi/aic7xxx.c,v
retrieving revision 1.118
diff -u -r1.118 aic7xxx.c
--- aic7xxx.c 1997/04/26 05:03:18 1.118
+++ aic7xxx.c 1997/05/29 16:31:23
@@ -1906,7 +1906,7 @@
if (ahc->scb_data->maxhscbs >= 16
|| (ahc->flags & AHC_PAGESCBS)) {
/* Default to 8 tags */
- xs->sc_link->opennings += 6;
+ xs->sc_link->opennings += 2;
} else {
/*
* Default to 4 tags on whimpy
----Next_Part(Mon_Jun__9_21:12:56_1997)----
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?199706091916.VAA16067>