MORE: 2.0.33 SCSI arrrggghhh!

Michael J Tubby B.Sc. G8TIC (mike@thorcom.com)
Mon, 22 Dec 1997 18:05:30 +0000


All,

I am still having problems with Adaptec ACI7xxx driver and 2.0.33 kernel
with SMP. This is a continuation of the post to this list last week.

Have been in touch wotu Doug directly, but thought I'd copy this to the
list so that others who get the same symptoms can see what I did to
collect data and/or help Doug investigate/fix it...

Doug wrote:

>Do me a favor (I don't have an SMP system so I can't test this out myself).
>Try to duplicate your problem, but boot linux with aic7xxx=verbose:2
>appended to your boot string (either with the append= directive in lilo or
>by typing it in manually when the machine boots) and see if you can get me
>some more information about the problem (remote syslog logging is your
>friend in this case :)
>
Doug, done what you asked for :-) ... and here's the low-down:

0. Reminder of symptoms

On SMP linux 2.0.33 (pair of PentiumPro 200s) with Adaptec AICxxx driver,
system hangs after burst of intensive I/O and gets stuck in a "Resetting
SCSI target N" loop for ever.

1. Reminder of hardware/software:

Intel Providence PR440FX, 128M ram, 2 x PPro-200 256K Cache, Step 9 CPU
On-board Adaptec AIC7xxx Ultra/Ultra-wide
SCSI devices: its a pretty busy bus... see dmesg contents below
Target (failing) machine called: golem.int.thorcom.com
Logged from: gate.int.thorcom.com (inside our firewall)
Both are RedHat 5.0 machines with mkfs version 1.10
Kernel: 2.0.33, from: ftp.kernel.org, clean: no patches, only enabled
SMP in the kernel (removed '#' from Makefile).

2. How I break it

golem# mkfs.ext2 /dev/sda2

seems to be a good way of breaking it! Prints all the inode numbers
and gets stuck and the end when it should be writing them away to disk.

3. Here's the kernel configuration; from make config

*
* SCSI support
*
SCSI support (CONFIG_SCSI) [Y/m/n/?]
*
* SCSI support type (disk, tape, CD-ROM)
*
SCSI disk support (CONFIG_BLK_DEV_SD) [Y/m/n/?]
SCSI tape support (CONFIG_CHR_DEV_ST) [Y/m/n/?]
SCSI CD-ROM support (CONFIG_BLK_DEV_SR) [Y/m/n/?]
SCSI generic support (CONFIG_CHR_DEV_SG) [Y/m/n/?]
*
* Some SCSI devices (e.g. CD jukebox) support multiple LUNs
*
Probe all LUNs on each SCSI device (CONFIG_SCSI_MULTI_LUN) [N/y/?]
Verbose SCSI error reporting (kernel size +=12K) (CONFIG_SCSI_CONSTANTS)
[Y/n/?]
*
* SCSI low-level drivers
*
7000FASST SCSI support (CONFIG_SCSI_7000FASST) [N/y/m/?]
Adaptec AHA152X/2825 support (CONFIG_SCSI_AHA152X) [N/y/m/?]
Adaptec AHA1542 support (CONFIG_SCSI_AHA1542) [N/y/m/?]
Adaptec AHA1740 support (CONFIG_SCSI_AHA1740) [N/y/m/?]
Adaptec AIC7xxx support (CONFIG_SCSI_AIC7XXX) [Y/m/n/?]
Enable tagged command queueing (CONFIG_AIC7XXX_TAGGED_QUEUEING) [Y/n/?]
Override driver defaults for commands per LUN (CONFIG_OVERRIDE_CMDS)
[Y/n/?]
Maximum number of commands per LUN (CONFIG_AIC7XXX_CMDS_PER_LUN) [32]
Enable SCB paging (CONFIG_AIC7XXX_PAGE_ENABLE) [Y/n/?]
Collect statistics to report in /proc (CONFIG_AIC7XXX_PROC_STATS) [N/y/?]
Delay in seconds after SCSI bus reset (CONFIG_AIC7XXX_RESET_DELAY) [15]
AdvanSys SCSI support (CONFIG_SCSI_ADVANSYS) [N/y/m/?]
Always IN2000 SCSI support (CONFIG_SCSI_IN2000) [N/y/m/?]
AM53/79C974 PCI SCSI support (CONFIG_SCSI_AM53C974) [N/y/m/?]
BusLogic SCSI support (CONFIG_SCSI_BUSLOGIC) [N/y/m/?]
DTC3180/3280 SCSI support (CONFIG_SCSI_DTC3280) [N/y/m/?]
EATA-DMA (DPT, NEC, AT&T, SNI, AST, Olivetti, Alphatronix) support
(CONFIG_SCSI_EATA_DMA) [N/y/m/?]
EATA-PIO (old DPT PM2001, PM2012A) support (CONFIG_SCSI_EATA_PIO) [N/y/m/?]
EATA ISA/EISA/PCI (DPT and generic EATA/DMA-compliant boards) support
(CONFIG_SCSI_EATA) [N/y/m/?]
Future Domain 16xx SCSI support (CONFIG_SCSI_FUTURE_DOMAIN) [N/y/m/?]
Generic NCR5380/53c400 SCSI support (CONFIG_SCSI_GENERIC_NCR5380) [N/y/m/?]
NCR53c406a SCSI support (CONFIG_SCSI_NCR53C406A) [N/y/m/?]
NCR53c7,8xx SCSI support (CONFIG_SCSI_NCR53C7xx) [N/y/m/?]
NCR53C8XX SCSI support (CONFIG_SCSI_NCR53C8XX) [N/y/m/?]
IOMEGA Parallel Port ZIP drive SCSI support (CONFIG_SCSI_PPA) [N/y/m/?]
PAS16 SCSI support (CONFIG_SCSI_PAS16) [N/y/m/?]
Qlogic FAS SCSI support (CONFIG_SCSI_QLOGIC_FAS) [N/y/m/?]
Qlogic ISP SCSI support (CONFIG_SCSI_QLOGIC_ISP) [N/y/m/?]
Seagate ST-02 and Future Domain TMC-8xx SCSI support (CONFIG_SCSI_SEAGATE)
[N/y/m/?]
Tekram DC-390(T) SCSI support (CONFIG_SCSI_DC390T) [N/y/m/?]
Trantor T128/T128F/T228 SCSI support (CONFIG_SCSI_T128) [N/y/m/?]
UltraStor 14F/34F support (CONFIG_SCSI_U14_34F) [N/y/m/?]
UltraStor SCSI support (CONFIG_SCSI_ULTRASTOR) [N/y/m/?]
GDT SCSI Disk Array Controller support (CONFIG_SCSI_GDTH) [N/y/m/?]

4. Contents of dmesg:

AHA274x/284x/294x (EISA/VLB/PCI-Fast SCSI) 4.1.1/3.2.1
scsi : 1 host.
scsi0: Scanning channel A for devices.
(scsi0:0:0:0) Synchronous at 10.0MHz, offset 15.
Vendor: FUJITSU Model: M1606S-512 Rev: 6220
Type: Direct-Access ANSI SCSI revision: 02
Detected scsi disk sda at scsi0, channel 0, id 0, lun 0
(scsi0:0:1:0) Synchronous at 10.0MHz, offset 15.
Vendor: HP Model: C3325A Rev: 5293
Type: Direct-Access ANSI SCSI revision: 02
Detected scsi disk sdb at scsi0, channel 0, id 1, lun 0
(scsi0:0:2:0) Synchronous at 10.0MHz, offset 15.
Vendor: MICROP Model: 3391NS Rev: x43h
Type: Direct-Access ANSI SCSI revision: 02
Detected scsi disk sdc at scsi0, channel 0, id 2, lun 0
(scsi0:0:3:0) Synchronous at 10.0MHz, offset 15.
Vendor: MICROP Model: 3391NS Rev: x43h
Type: Direct-Access ANSI SCSI revision: 02
Detected scsi disk sdd at scsi0, channel 0, id 3, lun 0
(scsi0:0:4:0) Using asynchronous transfers.
(scsi0:0:4:0) Rejecting unknown message (0x1) received from target,
SEQ_FLAGS=0x6
Vendor: HITACHI Model: CDR-6550 Rev: 0003
Type: CD-ROM ANSI SCSI revision: 02
Detected scsi CD-ROM sr0 at scsi0, channel 0, id 4, lun 0
(scsi0:0:5:0) Refusing synchronous negotiation; using asynchronous transfers.
Vendor: IMS Model: CDD2000/00 Rev: 1.25
Type: CD-ROM ANSI SCSI revision: 02
Detected scsi CD-ROM sr1 at scsi0, channel 0, id 5, lun 0
(scsi0:0:6:0) Synchronous at 5.0MHz, offset 8.
Vendor: SONY Model: SDT-5000 Rev: 3.30
Type: Sequential-Access ANSI SCSI revision: 02
Detected scsi tape st0 at scsi0, channel 0, id 6, lun 0
(scsi0:0:0:0) Enabled tagged queuing, queue depth 8.
(scsi0:0:1:0) Enabled tagged queuing, queue depth 8.
(scsi0:0:2:0) Enabled tagged queuing, queue depth 8.
(scsi0:0:3:0) Enabled tagged queuing, queue depth 8.
scsi : detected 1 SCSI tape 2 SCSI cdroms 4 SCSI disks total.
SCSI device sda: hdwr sector= 512 bytes. Sectors= 2131992 [1041 MB] [1.0 GB]
SCSI device sdb: hdwr sector= 512 bytes. Sectors= 4238836 [2069 MB] [2.1 GB]
SCSI device sdc: hdwr sector= 512 bytes. Sectors= 17780058 [8681 MB] [8.7 GB]
SCSI device sdd: hdwr sector= 512 bytes. Sectors= 17780058 [8681 MB] [8.7 GB]
PPP: version 2.2.0 (dynamic channel allocation)
TCP compression code copyright 1989 Regents of the University of California
PPP Dynamic channel allocation code copyright 1995 Caldera, Inc.
PPP line discipline registered.
SLIP: version 0.8.4-NET3.019-NEWTTY (dynamic channels, max=256).
CSLIP: code copyright 1989 Regents of the University of California.
Partition check:
sda: sda1 sda2
sdb: sdb1 sdb2
sdc: sdc1
sdd: sdd1
hda: hda1 hda2
VFS: Mounted root (ext2 filesystem) readonly.
Adding Swap: 130748k swap-space (priority -1)
EXT2-fs warning: mounting unchecked fs, running e2fsck is recommended
EXT2-fs warning: mounting unchecked fs, running e2fsck is recommended
EXT2-fs warning: mounting unchecked fs, running e2fsck is recommended
eepro100.c:v0.36 10/20/97 Donald Becker linux-eepro100@cesdis.gsfc.nasa.gov
Found Intel i82557 PCI Speedo at I/O 0xff40, IRQ 10.
PCI latency timer (CFLT) is 0x48.
eepro100.c:v0.36 10/20/97 Donald Becker linux-eepro100@cesdis.gsfc.nasa.gov
eth0: Intel EtherExpress Pro 10/100 at 0xff40, 00:A0:C9:49:C4:B4, IRQ 10.
Board assembly 645520-034, Physical connectors present: RJ45
Primary interface chip DP83840 PHY #1.
DP83840 specific setup, setting register 23 to 8462.
General self-test: passed.
Serial sub-system self-test: passed.
Internal registers self-test: passed.
ROM checksum self-test: passed (0x49caa8d6).
Receiver lock-up workaround activated.
eth0: speedo_open() irq 10.
eth0: Done speedo_open(), status 00000090.

5. Contents of syslog() from remote logger machine (gate)

Dec 22 11:15:51 golem.int.thorcom.com kernel: klogd 1.3-3, log source =
/proc/kmsg started.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Loaded 3829 symbols from
/boot/System.map.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Symbols match kernel version
2.0.33.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Loaded 3 symbols from 1 module.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Console: 16 point font, 400
scans
Dec 22 11:15:51 golem.int.thorcom.com kernel: Console: colour VGA+ 80x25, 1
virtual console (max 63)
Dec 22 11:15:51 golem.int.thorcom.com kernel: pcibios_init : BIOS32 Service
Directory structure at 0x000fd970
Dec 22 11:15:51 golem.int.thorcom.com kernel: pcibios_init : BIOS32 Service
Directory entry at 0xfd980
Dec 22 11:15:51 golem.int.thorcom.com kernel: pcibios_init : PCI BIOS
revision 2.10 entry at 0xfd9a1
Dec 22 11:15:51 golem.int.thorcom.com kernel: Probing PCI hardware.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Calibrating delay loop.. ok -
198.25 BogoMIPS
Dec 22 11:15:51 golem.int.thorcom.com kernel: Memory: 127900k/131072k
available (700k kernel code, 384k reserved, 2088k data)
Dec 22 11:15:51 golem.int.thorcom.com kernel: Swansea University Computer
Society NET3.035 for Linux 2.0
Dec 22 11:15:51 golem.int.thorcom.com kernel: NET3: Unix domain sockets
0.13 for Linux NET3.035.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Swansea University Computer
Society TCP/IP for NET3.034
Dec 22 11:15:51 golem.int.thorcom.com kernel: IP Protocols: ICMP, UDP, TCP,
IPIP
Dec 22 11:15:51 golem.int.thorcom.com kernel: Checking 386/387 coupling...
Ok, fpu using exception 16 error reporting.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Checking 'hlt' instruction...
Ok.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Linux version 2.0.33
(root@golem.int.thorcom.com) (gcc version 2.7.2.3) #1 Thu Dec 18 13:32:52
GMT 1997
Dec 22 11:15:51 golem.int.thorcom.com kernel: Starting kswapd v 1.4.2.2
Dec 22 11:15:51 golem.int.thorcom.com kernel: Serial driver version 4.13
with no serial options enabled
Dec 22 11:15:51 golem.int.thorcom.com kernel: tty00 at 0x03f8 (irq = 4) is
a 16550A
Dec 22 11:15:51 golem.int.thorcom.com kernel: tty01 at 0x02f8 (irq = 3) is
a 16550A
Dec 22 11:15:51 golem.int.thorcom.com kernel: ide: i82371 PIIX (Triton) on
PCI bus 0 function 57
Dec 22 11:15:51 golem.int.thorcom.com kernel: ide0: BM-DMA at
0xffa0-0xffa7
Dec 22 11:15:51 golem.int.thorcom.com kernel: ide1: BM-DMA at
0xffa8-0xffaf
Dec 22 11:15:51 golem.int.thorcom.com kernel: hda: ST32120A, 2014MB w/0kB
Cache, CHS=1023/64/63
Dec 22 11:15:51 golem.int.thorcom.com kernel: ide0 at 0x1f0-0x1f7,0x3f6 on
irq 14
Dec 22 11:15:51 golem.int.thorcom.com kernel: Floppy drive(s): fd0 is 1.44M
Dec 22 11:15:51 golem.int.thorcom.com kernel: FDC 0 is a National
Semiconductor PC87306
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: <Adaptec AIC-7880
Ultra SCSI host adapter> at PCI 9
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: Loading serial
EEPROM...done
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: Termination (Low ON,
High ON)
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: BIOS enabled, IO
Port 0xfc00, IO Mem 0xffbdf000, IRQ 11, Revision B
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: Extended translation
enabled.
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: Wide Channel, SCSI
ID 7, 16/255 SCBs, QFull 16, QMask 0x1f
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: Resetting channel A
Dec 22 11:15:51 golem.int.thorcom.com kernel: aic7xxx: Downloading
sequencer code... 409 instructions downloaded
Dec 22 11:15:51 golem.int.thorcom.com kernel: scsi0 : Adaptec
AHA274x/284x/294x (EISA/VLB/PCI-Fast SCSI) 4.1.1/3.2.1
Dec 22 11:15:51 golem.int.thorcom.com kernel: scsi : 1 host.
Dec 22 11:15:51 golem.int.thorcom.com kernel: scsi0: Scanning channel A for
devices.
Dec 22 11:15:51 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:15:51 golem.int.thorcom.com kernel: Vendor: FUJITSU Model:
M1606S-512 Rev: 6220
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: Direct-Access
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi disk sda at
scsi0, channel 0, id 0, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:1:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Vendor: HP Model:
C3325A Rev: 5293
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: Direct-Access
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi disk sdb at
scsi0, channel 0, id 1, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:2:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Vendor: MICROP Model:
3391NS Rev: x43h
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: Direct-Access
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi disk sdc at
scsi0, channel 0, id 2, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:3:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Vendor: MICROP Model:
3391NS Rev: x43h
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: Direct-Access
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi disk sdd at
scsi0, channel 0, id 3, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:4:0) Using
asynchronous transfers.
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:4:0) Rejecting
unknown message (0x1) received from target, SEQ_FLAGS=0x6
Dec 22 11:15:52 golem.int.thorcom.com kernel: Vendor: HITACHI Model:
CDR-6550 Rev: 0003
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: CD-ROM
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi CD-ROM sr0 at
scsi0, channel 0, id 4, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:5:0) Refusing
synchronous negotiation; using asynchronous transfers.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Vendor: IMS Model:
CDD2000/00 Rev: 1.25
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: CD-ROM
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi CD-ROM sr1 at
scsi0, channel 0, id 5, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:6:0) Synchronous at
5.0MHz, offset 8.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Vendor: SONY Model:
SDT-5000 Rev: 3.30
Dec 22 11:15:52 golem.int.thorcom.com kernel: Type: Sequential-Access
ANSI SCSI revision: 02
Dec 22 11:15:52 golem.int.thorcom.com kernel: Detected scsi tape st0 at
scsi0, channel 0, id 6, lun 0
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:0:0) Enabled tagged
queuing, queue depth 32.
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:1:0) Enabled tagged
queuing, queue depth 32.
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:2:0) Enabled tagged
queuing, queue depth 32.
Dec 22 11:15:52 golem.int.thorcom.com kernel: (scsi0:0:3:0) Enabled tagged
queuing, queue depth 32.
Dec 22 11:15:52 golem.int.thorcom.com kernel: scsi : detected 1 SCSI tape 2
SCSI cdroms 4 SCSI disks total.
Dec 22 11:15:52 golem.int.thorcom.com kernel: SCSI device sda: hdwr sector=
512 bytes. Sectors= 2131992 [1041 MB] [1.0 GB]
Dec 22 11:15:52 golem.int.thorcom.com kernel: SCSI device sdb: hdwr sector=
512 bytes. Sectors= 4238836 [2069 MB] [2.1 GB]
Dec 22 11:15:52 golem.int.thorcom.com kernel: SCSI device sdc: hdwr sector=
512 bytes. Sectors= 17780058 [8681 MB] [8.7 GB]
Dec 22 11:15:52 golem.int.thorcom.com kernel: SCSI device sdd: hdwr sector=
512 bytes. Sectors= 17780058 [8681 MB] [8.7 GB]
Dec 22 11:15:52 golem.int.thorcom.com kernel: tunnel: version v0.2b2
Dec 22 11:15:52 golem.int.thorcom.com kernel: Partition check:
Dec 22 11:15:52 golem.int.thorcom.com kernel: sda: sda1 sda2
Dec 22 11:15:52 golem.int.thorcom.com kernel: sdb: sdb1 sdb2
Dec 22 11:15:52 golem.int.thorcom.com kernel: sdc: sdc1
Dec 22 11:15:52 golem.int.thorcom.com kernel: sdd: sdd1
Dec 22 11:15:52 golem.int.thorcom.com kernel: hda: hda1 hda2
Dec 22 11:15:52 golem.int.thorcom.com kernel: VFS: Mounted root (ext2
filesystem) readonly.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Adding Swap: 130748k
swap-space (priority -1)
Dec 22 11:15:52 golem.int.thorcom.com kernel: EXT2-fs warning: mounting
unchecked fs, running e2fsck is recommended
Dec 22 11:15:52 golem.int.thorcom.com last message repeated 2 times
Dec 22 11:15:52 golem.int.thorcom.com kernel: eepro100.c:v0.36 10/20/97
Donald Becker linux-eepro100@cesdis.gsfc.nasa.gov
Dec 22 11:15:52 golem.int.thorcom.com kernel: Found Intel i82557 PCI Speedo
at I/O 0xff40, IRQ 10.
Dec 22 11:15:52 golem.int.thorcom.com kernel: PCI latency timer (CFLT) is
0x48.
Dec 22 11:15:52 golem.int.thorcom.com kernel: eepro100.c:v0.36 10/20/97
Donald Becker linux-eepro100@cesdis.gsfc.nasa.gov
Dec 22 11:15:52 golem.int.thorcom.com kernel: eth0: Intel EtherExpress Pro
10/100 at 0xff40, 00:A0:C9:49:C4:B4, IRQ 10.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Board assembly 645520-034,
Physical connectors present: RJ45
Dec 22 11:15:52 golem.int.thorcom.com kernel: Primary interface chip
DP83840 PHY #1.
Dec 22 11:15:52 golem.int.thorcom.com kernel: DP83840 specific setup,
setting register 23 to 8462.
Dec 22 11:15:52 golem.int.thorcom.com kernel: General self-test: passed.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Serial sub-system
self-test: passed.
Dec 22 11:15:52 golem.int.thorcom.com kernel: Internal registers
self-test: passed.
Dec 22 11:15:52 golem.int.thorcom.com kernel: ROM checksum self-test:
passed (0x49caa8d6).
Dec 22 11:15:52 golem.int.thorcom.com kernel: Receiver lock-up workaround
activated.
Dec 22 11:15:52 golem.int.thorcom.com named[230]: starting. named
4.9.6-REL Thu Nov 6 23:29:57 EST 1997
^Iroot@porky.redhat.com:/usr/src/bs/BUILD/bind-4.9.6/named
Dec 22 11:15:52 golem.int.thorcom.com named[230]: cache zone "" loaded
(serial 0)
Dec 22 11:15:52 golem.int.thorcom.com named[230]: primary zone
"0.0.127.in-addr.arpa" loaded (serial 1997022700)
Dec 22 11:15:52 golem.int.thorcom.com named[231]: Ready to answer queries.
Dec 22 11:16:12 golem.int.thorcom.com PAM_pwdb[329]: (login) session opened
for user root by (uid=0)
Dec 22 11:16:12 golem.int.thorcom.com PAM_pwdb[329]: ROOT LOGIN ON tty1

<- here's where i did the mkfs command! ->

Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4960, scsi0, channel 0, id 0, lun 0 Write (6) 02 34 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: (scsi0:0:0:0) Aborting scb 0,
flags 0x1
Dec 22 11:18:22 golem.int.thorcom.com kernel: (scsi0:0:0:0) SCB is
currently active. Waiting on completion.
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4961, scsi0, channel 0, id 0, lun 0 Write (6) 02 35 cd f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4962, scsi0, channel 0, id 0, lun 0 Write (6) 02 36 c1 18
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4963, scsi0, channel 0, id 0, lun 0 Write (6) 02 74 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4964, scsi0, channel 0, id 0, lun 0 Write (6) 02 75 cd ec
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4965, scsi0, channel 0, id 0, lun 0 Write (6) 02 76 b9 20
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4966, scsi0, channel 0, id 0, lun 0 Write (6) 02 b4 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4967, scsi0, channel 0, id 0, lun 0 Write (6) 02 b5 cd f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4968, scsi0, channel 0, id 0, lun 0 Write (6) 02 b6 c1 18
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4969, scsi0, channel 0, id 0, lun 0 Write (6) 02 f4 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4970, scsi0, channel 0, id 0, lun 0 Write (6) 02 f5 cd d4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4971, scsi0, channel 0, id 0, lun 0 Write (6) 02 f6 a1 38
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4972, scsi0, channel 0, id 0, lun 0 Write (6) 03 34 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4973, scsi0, channel 0, id 0, lun 0 Write (6) 03 35 cd f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4974, scsi0, channel 0, id 0, lun 0 Write (6) 03 36 c1 18
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4975, scsi0, channel 0, id 0, lun 0 Write (6) 03 74 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4976, scsi0, channel 0, id 0, lun 0 Write (6) 03 75 cd bc
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4977, scsi0, channel 0, id 0, lun 0 Write (6) 03 76 89 50
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4978, scsi0, channel 0, id 0, lun 0 Write (6) 03 b4 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4979, scsi0, channel 0, id 0, lun 0 Write (6) 03 b5 cd f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4980, scsi0, channel 0, id 0, lun 0 Write (6) 03 b6 c1 18
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4981, scsi0, channel 0, id 0, lun 0 Write (6) 03 f4 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4982, scsi0, channel 0, id 0, lun 0 Write (6) 03 f5 cd a4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4983, scsi0, channel 0, id 0, lun 0 Write (6) 03 f6 71 68
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4984, scsi0, channel 0, id 0, lun 0 Write (6) 04 34 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4985, scsi0, channel 0, id 0, lun 0 Write (6) 04 35 cd f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4986, scsi0, channel 0, id 0, lun 0 Write (6) 04 36 c1 18
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4987, scsi0, channel 0, id 0, lun 0 Write (6) 04 74 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4988, scsi0, channel 0, id 0, lun 0 Write (6) 04 75 cd 8c
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4989, scsi0, channel 0, id 0, lun 0 Write (6) 04 76 59 80
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4990, scsi0, channel 0, id 0, lun 0 Write (6) 04 b4 d9 f4
00
Dec 22 11:18:22 golem.int.thorcom.com kernel: scsi : aborting command due
to timeout : pid 4991, scsi0, channel 0, id 0, lun 0 Write (6) 04 b5 cd f4
00
Dec 22 11:18:39 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4960)
timed out - resetting
Dec 22 11:18:39 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:18:39 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 0, flags 0x41
Dec 22 11:18:39 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:18:39 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:18:39 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:18:39 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:19:16 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4960)
timed out - resetting
Dec 22 11:19:16 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x81
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:0:0) Bus Device
reset, scb flags 0x81, Data-Out phase, SCSISIGI 0x4, SEQADDR 0x123, SSTAT0
0x0, SSTAT1 0x2
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:0:0) Queueing device
reset command.
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 0 commands
found and queued for completion.
Dec 22 11:19:16 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4961)
timed out - resetting
Dec 22 11:19:16 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 1, flags 0x81
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:19:16 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:19:53 golem.int.thorcom.com kernel: SCSI host 0 channel 0 reset
(pid 4960) timed out - trying harder
Dec 22 11:19:53 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:19:53 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:19:53 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:19:53 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:19:53 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:19:53 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:20:30 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4960)
timed out - resetting
Dec 22 11:20:30 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:0:0) Bus Device
reset, scb flags 0x1, Data-Out phase, SCSISIGI 0x4, SEQADDR 0x124, SSTAT0
0x0, SSTAT1 0x2
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:0:0) Device reset
message in message buffer
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 0 commands
found and queued for completion.
Dec 22 11:20:30 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4961)
timed out - resetting
Dec 22 11:20:30 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 31, flags 0x81
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:20:30 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:21:07 golem.int.thorcom.com kernel: SCSI host 0 channel 0 reset
(pid 4960) timed out - trying harder
Dec 22 11:21:07 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:21:07 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:21:07 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:21:07 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:21:07 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:21:07 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:21:44 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4960)
timed out - resetting
Dec 22 11:21:44 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:0:0) Bus Device
reset, scb flags 0x1, Data-Out phase, SCSISIGI 0x4, SEQADDR 0x123, SSTAT0
0x0, SSTAT1 0x2
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:0:0) Device reset
message in message buffer
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 0 commands
found and queued for completion.
Dec 22 11:21:44 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4961)
timed out - resetting
Dec 22 11:21:44 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 28, flags 0x1
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:21:44 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:22:21 golem.int.thorcom.com kernel: SCSI host 0 channel 0 reset
(pid 4960) timed out - trying harder
Dec 22 11:22:21 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:22:21 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:22:21 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:22:21 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:22:21 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:22:21 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:22:58 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4960)
timed out - resetting
Dec 22 11:22:58 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:0:0) Bus Device
reset, scb flags 0x1, Data-Out phase, SCSISIGI 0x4, SEQADDR 0x123, SSTAT0
0x0, SSTAT1 0x2
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:0:0) Device reset
message in message buffer
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 0 commands
found and queued for completion.
Dec 22 11:22:58 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4961)
timed out - resetting
Dec 22 11:22:58 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 26, flags 0x1
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:22:58 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:23:35 golem.int.thorcom.com kernel: SCSI host 0 channel 0 reset
(pid 4960) timed out - trying harder
Dec 22 11:23:35 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:23:35 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:23:35 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:23:35 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:23:35 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:23:35 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:24:12 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4960)
timed out - resetting
Dec 22 11:24:12 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:0:0) Bus Device
reset, scb flags 0x1, Data-Out phase, SCSISIGI 0x4, SEQADDR 0x124, SSTAT0
0x0, SSTAT1 0x2
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:0:0) Device reset
message in message buffer
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 0 commands
found and queued for completion.
Dec 22 11:24:12 golem.int.thorcom.com kernel: SCSI host 0 abort (pid 4961)
timed out - resetting
Dec 22 11:24:12 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 24, flags 0x1
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:24:12 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.
Dec 22 11:24:49 golem.int.thorcom.com kernel: SCSI host 0 channel 0 reset
(pid 4960) timed out - trying harder
Dec 22 11:24:49 golem.int.thorcom.com kernel: SCSI bus is being reset for
host 0 channel 0.
Dec 22 11:24:49 golem.int.thorcom.com kernel: (scsi0:0:0:0) Reset called,
scb 32, flags 0x1
Dec 22 11:24:49 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Reset channel
called, will initiate reset.
Dec 22 11:24:49 golem.int.thorcom.com kernel: (scsi0:0:-1:-1) Channel reset
Dec 22 11:24:49 golem.int.thorcom.com kernel: (scsi0:-1:-1:-1) 32 commands
found and queued for completion.
Dec 22 11:24:49 golem.int.thorcom.com kernel: (scsi0:0:0:0) Synchronous at
10.0MHz, offset 15.

<- here's where I hit the reset ->

At this point all access to the system is denied:

a) Ctrl-alt-del is ignored

b) Alt-Fn to switch virtual terminals is ignored

the machine is dead and looping for ever.

Hope this lot helps!

Regards and seasons greetings.

Mike Tubby

--
Michael J Tubby  B.Sc.  G8TIC
Technical Director, Thorcom Systems Limited
Tel: 01 905 756700 (intl: +44 1 905 756 700)
Fax: 01 905 755777 (intl: +44 1 905 755 777)
Web: http://www.thorcom.com
Email: mike@thorcom.com