Date: Sun, 9 Jan 2000 13:49:16 +0100 From: "Dave J. Boers" <djb@relativity.student.utwente.nl> To: freebsd-current@freebsd.org Subject: Strange SCSI related system hang Message-ID: <20000109134916.A382@relativity.student.utwente.nl>
next in thread | raw e-mail | index | archive | help
Hi all,
This morning I had a very strange (at least I've never seen it before) SCSI
related system hang. The system simply stopped responding at 9:30:03 am
this morning. I found it in this state at 13:20. It had been hanging
_hard_. No response to console, serial terminal or network. After a hard
reset the system came back online normally and is working normally again.
Note that the machine had an uptime of 4 days, 14 hours before the problem
occured and it never happened before.
Could this be a hardware problem?
====> uname -a:
FreeBSD relativity.student.utwente.nl 4.0-CURRENT FreeBSD 4.0-CURRENT #0:
Thu Dec 30 21:42:21 CET 1999
root@relativity.student.utwente.nl:/usr/src/sys/compile/RELATIVITY3 i386
====> Here's the relevant system log messages:
Note that all these messages occur at xx:30:00 or xx:30:01. That's probably
related to a cron job which runs every half hour and copies some files
(about 20 Mb) from my IDE disk to my SCSI disk. When the system is idle,
there's usually no other SCSI activity.
Jan 9 04:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 04:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 04:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 04:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 04:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 04:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 04:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 04:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 04:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 04:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 04:30:01 relativity /kernel: ahc0:A:0: no active SCB for reconnecting target - issuing BUS DEVICE RESET
Jan 9 06:30:00 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 06:30:00 relativity /kernel: SEQADDR == 0x151
Jan 9 07:30:00 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 07:30:00 relativity /kernel: SEQADDR == 0x151
Jan 9 07:30:00 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 07:30:00 relativity /kernel: SEQADDR == 0x151
Jan 9 07:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 07:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 07:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 07:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 07:30:01 relativity /kernel: ahc0:A:0: no active SCB for reconnecting target - issuing BUS DEVICE RESET
Jan 9 07:30:01 relativity /kernel: SAVED_TCL == 0x0, ARG_1 == 0x9, SEQ_FLAGS == 0x0
Jan 9 07:30:01 relativity /kernel: ahc0: Bus Device Reset on A:0. 1 SCBs aborted
Jan 9 08:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 08:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 08:30:01 relativity /kernel: Unexpected busfree. LASTPHASE == 0xa0
Jan 9 08:30:01 relativity /kernel: SEQADDR == 0x151
Jan 9 09:30:03 relativity /kernel: (da0:ahc0:0:0:0): Invalidating pack
====> Here's my complete dmesg output:
Copyright (c) 1992-1999 The FreeBSD Project.
Copyright (c) 1982, 1986, 1989, 1991, 1993
The Regents of the University of California. All rights reserved.
FreeBSD 4.0-CURRENT #0: Thu Dec 30 21:42:21 CET 1999
root@relativity.student.utwente.nl:/usr/src/sys/compile/RELATIVITY3
Timecounter "i8254" frequency 1193182 Hz
CPU: Pentium II/Celeron (450.00-MHz 686-class CPU)
Origin = "GenuineIntel" Id = 0x665 Stepping = 5
Features=0x183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR>
real memory = 134217728 (131072K bytes)
avail memory = 127238144 (124256K bytes)
Programming 24 pins in IOAPIC #0
FreeBSD/SMP: Multiprocessor motherboard
cpu0 (BSP): apic id: 0, version: 0x00040011, at 0xfee00000
cpu1 (AP): apic id: 1, version: 0x00040011, at 0xfee00000
io0 (APIC): apic id: 2, version: 0x00170011, at 0xfec00000
Preloaded elf kernel "kernel" at 0xc02d2000.
Preloaded elf module "vesa.ko" at 0xc02d209c.
VESA: v3.0, 7936k memory, flags:0x1, mode table:0xc02cf102 (1000022)
VESA: NVidia
Pentium Pro MTRR support enabled
npx0: <math processor> on motherboard
npx0: INT 16 interface
pcib0: <Intel 82443BX (440 BX) host to PCI bridge> on motherboard
pci0: <PCI bus> on pcib0
pcib1: <Intel 82443BX (440 BX) PCI-PCI (AGP) bridge> at device 1.0 on pci0
pci1: <PCI bus> on pcib1
vga-pci0: <NVidia Riva TNT graphics accelerator> irq 16 at device 0.0 on pci1
isab0: <Intel 82371AB PCI to ISA bridge> at device 7.0 on pci0
isa0: <ISA bus> on isab0
ata-pci0: <Intel PIIX4 ATA controller> at device 7.1 on pci0
ata-pci0: Busmastering DMA supported
pci0: Intel 82371AB/EB (PIIX4) USB controller (vendor=0x8086, dev=0x7112) at 7.2
intpm0: <Intel 82371AB Power management controller> at device 7.3 on pci0
intpm0: I/O mapped 5000
intpm0: intr IRQ 9 enabled revision 0
smbus0: <System Management Bus> on intsmb0
smb0: <SMBus general purpose I/O> on smbus0
intpm0: PM I/O mapped 4000
ed0: <NE2000 PCI Ethernet (RealTek 8029)> irq 19 at device 9.0 on pci0
ed0: address 00:20:18:2d:d5:2b, type NE2000 (16 bit)
ahc0: <Adaptec 2940A Ultra SCSI adapter> irq 18 at device 11.0 on pci0
ahc0: aic7860 Single Channel A, SCSI Id=7, 3/255 SCBs
pci0: unknown card (vendor=0x10b7, dev=0x9055) at 13.0 irq 17
ata-pci1: <HighPoint HPT366 ATA controller> irq 18 at device 19.0 on pci0
ata-pci1: Busmastering DMA supported
ata2 at 0xb000 irq 11 on ata-pci1
ata-pci2: <HighPoint HPT366 ATA controller> irq 18 at device 19.1 on pci0
ata-pci2: Busmastering DMA supported
fdc0: <NEC 72065B or clone> at port 0x3f0-0x3f7 irq 6 drq 2 on isa0
fdc0: FIFO enabled, 8 bytes threshold
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
atkbdc0: <keyboard controller (i8042)> at port 0x60-0x6f on isa0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: model Generic PS/2 mouse, device ID 0
vga0: <Generic ISA VGA> at port 0x3b0-0x3df iomem 0xa0000-0xbffff on isa0
sc0: <System console> on isa0
sc0: VGA <16 virtual consoles, flags=0x200>
sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
sio0: type 16550A
sio1 at port 0x2f8-0x2ff irq 3 on isa0
sio1: type 16550A
sio2: not probed (disabled)
sio3: not probed (disabled)
ppc0 at port 0x378-0x37f irq 7 flags 0x40 on isa0
ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
ppb0: IEEE1284 device found /NIBBLE
Probing for PnP devices on ppbus0:
ppbus0: <Hewlett-Packard HP LaserJet 5L/0101.02> HP ENHANCED PCL5,PJL
plip0: <PLIP network interface> on ppbus 0
lpt0: <generic printer> on ppbus 0
lpt0: Interrupt-driven port
ppi0: <generic parallel i/o> on ppbus 0
sbc0: <Creative SB16/SB32> at port 0x220-0x22f,0x330-0x331,0x388-0x38b irq 5 drq 1,5 on isa0
sbc0: setting card to irq 5, drq 1, 5
pcm0: <SB DSP 4.13> on sbc0
unknown0: <Generic ESDI/IDE/ATA controller> at port 0x168-0x16f,0x36e-0x36f irq 10 on isa0
unknown1: <StereoEnhance> at port 0x100 on isa0
unknown2: <Game> at port 0x200-0x207 on isa0
unknown: <PNP0000> can't assign resources
unknown3: <PNP0200> at port 0-0xf,0x81-0x83,0x87,0x89-0x8b,0x8f-0x91,0xc0-0xdf drq 4 on isa0
unknown4: <PNP0100> at port 0x40-0x43 irq 0 on isa0
unknown5: <PNP0b00> at port 0x70-0x71 irq 8 on isa0
unknown: <PNP0303> can't assign resources
unknown: <PNP0800> can't assign resources
unknown6: <PNP0c04> at port 0xf0-0xff irq 13 on isa0
unknown7: <PNP0c01> at iomem 0-0x9ffff,0xfffe0000-0xffffffff,0xfec00000-0xfec0ffff,0xfee00000-0xfee0ffff,0x100000-0x7ffffff on isa0
unknown8: <PNP0c02> at iomem 0xf0000-0xf3fff,0xf4000-0xf7fff,0xf8000-0xfffff,0xce800-0xcffff on isa0
unknown: <PNP0a03> can't assign resources
unknown: <PNP0f13> can't assign resources
unknown9: <PNP0c02> at port 0x208-0x20f on isa0
unknown: <PNP0501> can't assign resources
unknown: <PNP0700> can't assign resources
unknown: <PNP0400> can't assign resources
unknown: <PNP0501> can't assign resources
APIC_IO: Testing 8254 interrupt delivery
APIC_IO: routing 8254 via pin 2
IP packet filtering initialized, divert enabled, rule-based forwarding disabled, logging limited to 100 packets/entry by default
SMP: AP CPU #1 Launched!
ad0: <WDC AC418000D/J78OA30K> ATA-4 disk at ata2 as master
ad0: 17206MB (35239680 sectors), 34960 cyls, 16 heads, 63 S/T, 512 B/S
ad0: 16 secs/int, 32 depth queue, UDMA66
Waiting 5 seconds for SCSI devices to settle
sa0 at ahc0 bus 0 target 4 lun 0
sa0: <TANDBERG TDC 3800 =07:> Removable Sequential Access SCSI-2 device
sa0: 3.300MB/s transfers
Mounting root from ufs:/dev/ad0s1a
cd1 at ahc0 bus 0 target 2 lun 0
cd1: <TEAC CD-ROM CD-516S 1.0D> Removable CD-ROM SCSI-2 device
cd1: 10.000MB/s transfers (10.000MHz, offset 8)
cd1: cd present [309750 x 2048 byte records]
cd0 at ahc0 bus 0 target 1 lun 0
cd0: <PLEXTOR CD-R PX-R412C 1.05> Removable CD-ROM SCSI-2 device
cd0: 10.000MB/s transfers (10.000MHz, offset 8)
cd0: Attempt to query device size failed: NOT READY, Medium not present
WARNING: / was not properly dismounted
da0 at ahc0 bus 0 target 0 lun 0
da0: <WDIGTL ENTERPRISE 1.70> Fixed Direct Access SCSI-2 device
da0: 20.000MB/s transfers (20.000MHz, offset 15)
da0: 4157MB (8515173 512 byte sectors: 255H 63S/T 530C)
da1 at ahc0 bus 0 target 5 lun 0
da1: <IOMEGA ZIP 100 J.02> Removable Direct Access SCSI-2 device
da1: 3.300MB/s transfers
da1: 96MB (196608 512 byte sectors: 64H 32S/T 96C)
pci0: Intel 82371AB/EB (PIIX4) USB controller (vendor=0x8086, dev=0x7112) at 7.2
xl0: <3Com 3c905B-TX Fast Etherlink XL> irq 17 at device 13.0 on pci0
xl0: Ethernet address: 00:10:5a:65:33:80
miibus0: <MII bus> on xl0
xlphy0: <3Com internal media interface> on miibus0
xlphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
If you need any more information, please let me know. I can also provide an
account on the machine.
Regards,
Dave Boers.
--
djb@relativity.student.utwente.nl
To Unsubscribe: send mail to majordomo@FreeBSD.org
with "unsubscribe freebsd-current" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20000109134916.A382>