ATA issues: ad0: FAILURE - ATA_IDENTIFY no interrupt

From: David Wolfskill <david_at_catwhisker.org>
Date: Sun, 8 Aug 2004 11:49:41 -0700 (PDT)
This looks fairly unpleasant.  Local CVS repo synced between 03:45 -
03:53 hrs. US/Pacific (PDT).  Had one lockup during the "make -j8
buildworld," in the "stage 4.2: building libraries" phase, while
lic_r was being built.  (This also happened 3 of the previous 4
days, but not yesterday; it's an SMP system.)  Rest, reboot to
single user, "fsck -p && reboot || fsck -y" rebooted to multi-user
OK, and I started the "make -j8 buildworld" over again, and this
time it completed without incident.  Built & installed the new
kernel, installed world, mergemaster, reboot.  Started seeing a
bit of oddness with respect to module g_md (I use a swap-backed
/tmp), and then ata0 & ad0 reported problems.

Here's a cut/paste from my (serial) console:


Sun Aug  8 09:50:13 PDT 2004

FreeBSD/i386 (freebeast.catwhisker.org) (cuaa0)

login: Augboot() called on cpu#1
Waiting (max 60 seconds) for system process `vnlru' to stop...done
Waiting (max 60 seconds) for system process `bufdaemon' to stop...done
Waiting (max 60 seconds) for system process `syncer' to stop...
Syncer syncing, vnodes remaining...5 0 3 0 1 0 1 0 1 0 1 0 0 0 done
Uptime: 1h44m59s
Shutting down ACPI
    ACPI-0265: *** Error: Hardware never changed modes
Rebooting...
cpu_reset called on cpu#1
cpu_reset: Stopping other CPUs
cpu_reset: Restarting BSP
cpu_reset_proxy: Stopped CPU 1
Console: serial port
BIOS drive A: is disk0
BIOS drive C: is disk1
BIOS 639kB/523200kB available memory

FreeBSD/i386 bootstrap loader, Revision 1.1
(root_at_freebeast.catwhisker.org, Sun Aug  8 10:22:51 PDT 2004)
Loading /boot/defaults/loader.conf 
/boot/kernel/kernel text=0x2ac338 data=0x31e18+0x3e5e8 syms=[0x4+0x3e860+0x4+0x4e1b6]
/boot/kernel/snd_cmi.ko text=0x2c50 data=0x29c syms=[0x4+0x9d0+0x4+0x9a8]
loading required module 'sound'
/boot/kernel/sound.ko text=0x13884 data=0x2794+0x10b8 syms=[0x4+0x2b80+0x4+0x30a0]

Hit [Enter] to boot immediately, or any other key for command prompt.
Booting [/boot/kernel/kernel]...               
/boot/kernel/acpi.ko text=0x3eba8 data=0x1a84+0xd2c syms=[0x4+0x6f60+0x4+0x90e8]
GDB: no debug ports present
KDB: debugger backends: ddb
KDB: current backend: ddb
SMAP type=01 base=0000000000000000 len=000000000009fc00
SMAP type=01 base=000000000009fc00 len=0000000000000400
SMAP type=02 base=00000000000f0000 len=0000000000010000
SMAP type=02 base=00000000fec00000 len=0000000001400000
SMAP type=01 base=0000000000100000 len=000000001fef0000
SMAP type=03 base=000000001fff3000 len=000000000000d000
SMAP type=04 base=000000001fff0000 len=0000000000003000
Copyright (c) 1992-2004 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
        The Regents of the University of California. All rights reserved.
FreeBSD 5.2-CURRENT #42: Sun Aug  8 11:08:52 PDT 2004
    root_at_freebeast.catwhisker.org:/common/S4/obj/usr/src/sys/FREEBEAST
WARNING: DIAGNOSTIC option enabled, expect reduced performance.
Preloaded elf kernel "/boot/kernel/kernel" at 0xc0822000.
Preloaded elf module "/boot/kernel/snd_cmi.ko" at 0xc08221f4.
Preloaded elf module "/boot/kernel/sound.ko" at 0xc08222a0.
Preloaded elf module "/boot/kernel/acpi.ko" at 0xc082234c.
Calibrating clock(s) ... i8254 clock: 1193283 Hz
CLK_USE_I8254_CALIBRATION not specified - using default frequency
Timecounter "i8254" frequency 1193182 Hz quality 0
Calibrating TSC clock ... TSC clock: 876397877 Hz
CPU: Intel Pentium III (876.40-MHz 686-class CPU)
  Origin = "GenuineIntel"  Id = 0x68a  Stepping = 10
  Features=0x383fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
real memory  = 536805376 (511 MB)
Physical memory chunk(s):
0x0000000000001000 - 0x000000000009efff, 647168 bytes (158 pages)
0x0000000000100000 - 0x00000000003fffff, 3145728 bytes (768 pages)
0x0000000000c29000 - 0x000000001f6bffff, 514420736 bytes (125591 pages)
avail memory = 515739648 (491 MB)
Table 'FACP' at 0x1fff3040
Table 'APIC' at 0x1fff6280
MADT: Found table at 0x1fff6280
MP Configuration Table version 1.4 found at 0xc00f1400
APIC: Using the MADT enumerator.
MADT: Found CPU APIC ID 0 ACPI ID 0: enabled
SMP: Added CPU 0 (AP)
MADT: Found CPU APIC ID 1 ACPI ID 1: enabled
SMP: Added CPU 1 (AP)
ACPI APIC Table: <VIA694 AWRDACPI>
APIC ID: physical 0, logical 0:0
APIC ID: physical 1, logical 0:1
FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
 cpu0 (BSP): APIC ID:  0
 cpu1 (AP): APIC ID:  1
bios32: Found BIOS32 Service Directory header at 0xc00faf20
bios32: Entry = 0xfb390 (c00fb390)  Rev = 0  Len = 1
pcibios: PCI BIOS entry at 0xf0000+0xb3c0
pnpbios: Found PnP BIOS data at 0xc00fbde0
pnpbios: Entry = f0000:be10  Rev = 1.0
Other BIOS signatures found:
APIC: CPU 0 has ACPI ID 0
APIC: CPU 1 has ACPI ID 1
MADT: Found IO APIC ID 2, Interrupt 0 at 0xfec00000
ioapic0: Routing external 8259A's -> intpin 0
ioapic0: intpin 0 -> ExtINT (edge, high)
ioapic0: intpin 1 -> ISA IRQ 1 (edge, high)
ioapic0: intpin 2 -> ISA IRQ 2 (edge, high)
ioapic0: intpin 3 -> ISA IRQ 3 (edge, high)
ioapic0: intpin 4 -> ISA IRQ 4 (edge, high)
ioapic0: intpin 5 -> ISA IRQ 5 (edge, high)
ioapic0: intpin 6 -> ISA IRQ 6 (edge, high)
ioapic0: intpin 7 -> ISA IRQ 7 (edge, high)
ioapic0: intpin 8 -> ISA IRQ 8 (edge, high)
ioapic0: intpin 9 -> ISA IRQ 9 (edge, high)
ioapic0: intpin 10 -> ISA IRQ 10 (edge, high)
ioapic0: intpin 11 -> ISA IRQ 11 (edge, high)
ioapic0: intpin 12 -> ISA IRQ 12 (edge, high)
ioapic0: intpin 13 -> ISA IRQ 13 (edge, high)
ioapic0: intpin 14 -> ISA IRQ 14 (edge, high)
ioapic0: intpin 15 -> ISA IRQ 15 (edge, high)
ioapic0: intpin 16 -> PCI IRQ 16 (level, low)
ioapic0: intpin 17 -> PCI IRQ 17 (level, low)
ioapic0: intpin 18 -> PCI IRQ 18 (level, low)
ioapic0: intpin 19 -> PCI IRQ 19 (level, low)
ioapic0: intpin 20 -> PCI IRQ 20 (level, low)
ioapic0: intpin 21 -> PCI IRQ 21 (level, low)
ioapic0: intpin 22 -> PCI IRQ 22 (level, low)
ioapic0: intpin 23 -> PCI IRQ 23 (level, low)
MADT: intr override: source 0, irq 2
ioapic0: Routing IRQ 0 -> intpin 2
ioapic0: intpin 2 trigger: edge
ioapic0: intpin 2 polarity: high
MADT: intr override: source 9, irq 9
ioapic0: intpin 9 trigger: level
ioapic0: intpin 9 polarity: low
ioapic0 <Version 1.1> irqs 0-23 on motherboard
cpu0 BSP:
     ID: 0x00000000   VER: 0x00040011 LDR: 0x01000000 DFR: 0x0fffffff
  lint0: 0x00010700 lint1: 0x00000400 TPR: 0x00000000 SVR: 0x000001ff
wlan: <802.11 Link Layer>
null: <null device, zero device>
random: <entropy source, Software, Yarrow>
io: <I/O>
mem: <memory>
Pentium Pro MTRR support enabled
npx0: [FAST]
npx0: <math processor> on motherboard
npx0: INT 16 interface
acpi0: <VIA694 AWRDACPI> on motherboard
acpi0: [GIANT-LOCKED]
pci_open(1):    mode 1 addr port (0x0cf8) is 0x80000060
pci_open(1a):   mode1res=0x80000000 (0x80000000)
pci_cfgcheck:   device 0 [class=060000] [hdr=00] is there (id=30911106)
pcibios: BIOS version 2.10
Found $PIR table, 8 entries at 0xc00fde30
PCI-Only Interrupts: 5 10 11 12
Location  Bus Device Pin  Link  IRQs
slot 1      0    9    A   0x01  3 4 5 7 9 10 11 12 14 15
slot 1      0    9    B   0x02  3 4 5 7 9 10 11 12 14 15
slot 1      0    9    C   0x03  3 4 5 7 9 10 11 12 14 15
slot 1      0    9    D   0x04  3 4 5 7 9 10 11 12 14 15
slot 2      0   10    A   0x02  3 4 5 7 9 10 11 12 14 15
slot 2      0   10    B   0x03  3 4 5 7 9 10 11 12 14 15
slot 2      0   10    C   0x04  3 4 5 7 9 10 11 12 14 15
slot 2      0   10    D   0x01  3 4 5 7 9 10 11 12 14 15
slot 3      0   11    A   0x03  3 4 5 7 9 10 11 12 14 15
slot 3      0   11    B   0x04  3 4 5 7 9 10 11 12 14 15
slot 3      0   11    C   0x01  3 4 5 7 9 10 11 12 14 15
slot 3      0   11    D   0x02  3 4 5 7 9 10 11 12 14 15
slot 4      0   12    A   0x04  3 4 5 7 9 10 11 12 14 15
slot 4      0   12    B   0x01  3 4 5 7 9 10 11 12 14 15
slot 4      0   12    C   0x02  3 4 5 7 9 10 11 12 14 15
slot 4      0   12    D   0x03  3 4 5 7 9 10 11 12 14 15
slot 5      0   13    A   0x01  3 4 5 7 9 10 11 12 14 15
slot 5      0   13    B   0x02  3 4 5 7 9 10 11 12 14 15
slot 5      0   13    C   0x03  3 4 5 7 9 10 11 12 14 15
slot 5      0   13    D   0x04  3 4 5 7 9 10 11 12 14 15
slot 6      0   14    A   0x02  3 4 5 7 9 10 11 12 14 15
slot 6      0   14    B   0x03  3 4 5 7 9 10 11 12 14 15
slot 6      0   14    C   0x04  3 4 5 7 9 10 11 12 14 15
slot 6      0   14    D   0x01  3 4 5 7 9 10 11 12 14 15
slot 7      0   15    A   0x03  3 4 5 7 9 10 11 12 14 15
slot 7      0   15    B   0x04  3 4 5 7 9 10 11 12 14 15
slot 7      0   15    C   0x01  3 4 5 7 9 10 11 12 14 15
slot 7      0   15    D   0x02  3 4 5 7 9 10 11 12 14 15
embedded    0    1    A   0x01  3 4 5 7 9 10 11 12 14 15
embedded    0    1    B   0x02  3 4 5 7 9 10 11 12 14 15
embedded    0    1    C   0x03  3 4 5 7 9 10 11 12 14 15
embedded    0    1    D   0x04  3 4 5 7 9 10 11 12 14 15
acpi_bus_number: root bus has no _BBN, assuming 0
AcpiOsDerivePciId: bus 0 dev 17 func 0
acpi0: Power Button (fixed)
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
ACPI timer looks GOOD min = 2, max = 3, width = 1
Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x4008-0x400b on acpi0
cpu0: <ACPI CPU (3 Cx states)> on acpi0
cpu1: <ACPI CPU (3 Cx states)> on acpi0
acpi_tz0: <Thermal Zone> on acpi0
acpi_button0: <Power Button> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0x5000-0x500f,0x4080-0x40ff,0x4000-0x407f,0xcf8-0xcff on acpi0
pcib0: could not get PCI interrupt routing table for \_SB_.PCI0 - AE_BAD_DATA
ACPI PCI link initial configuration:
ACPI PCI link before setting link priority:
ACPI PCI link before fixup for boot-disabled links:
ACPI PCI link after fixup for boot-disabled links:
ACPI PCI link arbitrated configuration:
pci0: <ACPI PCI bus> on pcib0
pci0: physical bus=0
        map[10]: type 3, range 32, base da000000, size 22, enabled
found-> vendor=0x1106, dev=0x3091, revid=0x01
        bus=0, slot=0, func=0
        class=06-00-00, hdrtype=0x00, mfdev=0
        cmdreg=0x0006, statreg=0xa210, cachelnsz=0 (dwords)
        lattimer=0x08 (240 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
        powerspec 2  supports D0 D3  current D0
found-> vendor=0x1106, dev=0xb091, revid=0x00
        bus=0, slot=1, func=0
        class=06-04-00, hdrtype=0x01, mfdev=0
        cmdreg=0x0007, statreg=0x2230, cachelnsz=0 (dwords)
        lattimer=0x00 (0 ns), mingnt=0x0c (3000 ns), maxlat=0x00 (0 ns)
        map[10]: type 4, range 32, base 0000c000, size  7, enabled
        map[14]: type 1, range 32, base da401000, size  7, enabled
pcib0: matched entry for 0.9.INTA (src )
pcib0: device is hardwired to IRQ 16
found-> vendor=0x10ec, dev=0x8129, revid=0x00
        bus=0, slot=9, func=0
        class=02-00-00, hdrtype=0x00, mfdev=0
        cmdreg=0x0007, statreg=0x0200, cachelnsz=0 (dwords)
        lattimer=0x20 (960 ns), mingnt=0x20 (8000 ns), maxlat=0x40 (16000 ns)
        intpin=a, irq=16
        map[10]: type 4, range 32, base 0100c400, size  7, enabled
        map[14]: type 1, range 32, base d9000000, size  7, enabled
        map[18]: type 1, range 32, base 01000000, size 24, enabled
        map[1c]: type 1, range 32, base 01000000, size 24, enabled
        map[20]: type 1, range 32, base 01000000, size 24, enabled
        map[24]: type 1, range 32, base 01000000, size 24, enabled
pcib0: matched entry for 0.10.INTA (src )
pcib0: device is hardwired to IRQ 17
found-> vendor=0x1106, dev=0x3143, revid=0x06
        bus=0, slot=10, func=0
        class=03-00-00, hdrtype=0x00, mfdev=0
        cmdreg=0x0007, statreg=0x0300, cachelnsz=8 (dwords)
        lattimer=0x20 (960 ns), mingnt=0x76 (29500 ns), maxlat=0x99 (38250 ns)
        intpin=a, irq=17
        map[10]: type 4, range 32, base 0000c800, size  8, enabled
pcib0: matched entry for 0.14.INTA (src )
pcib0: device is hardwired to IRQ 17
found-> vendor=0x13f6, dev=0x0111, revid=0x10
        bus=0, slot=14, func=0
        class=04-01-00, hdrtype=0x00, mfdev=0
        cmdreg=0x0005, statreg=0x0210, cachelnsz=0 (dwords)
        lattimer=0x20 (960 ns), mingnt=0x02 (500 ns), maxlat=0x18 (6000 ns)
        intpin=a, irq=17
        powerspec 2  supports D0 D1 D2 D3  current D0
        map[10]: type 4, range 32, base 0000cc00, size  3, enabled
        map[14]: type 4, range 32, base 0000d000, size  2, enabled
        map[18]: type 4, range 32, base 0000d400, size  3, enabled
        map[1c]: type 4, range 32, base 0000d800, size  2, enabled
        map[20]: type 4, range 32, base 0000dc00, size  4, enabled
pcib0: matched entry for 0.15.INTA (src )
pcib0: device is hardwired to IRQ 18
found-> vendor=0x1095, dev=0x0649, revid=0x02
        bus=0, slot=15, func=0
        class=01-04-00, hdrtype=0x00, mfdev=0
        cmdreg=0x0007, statreg=0x0290, cachelnsz=0 (dwords)
        lattimer=0x20 (960 ns), mingnt=0x02 (500 ns), maxlat=0x04 (1000 ns)
        intpin=a, irq=18
        powerspec 2  supports D0 D1 D2 D3  current D0
found-> vendor=0x1106, dev=0x3074, revid=0x00
        bus=0, slot=17, func=0
        class=06-01-00, hdrtype=0x00, mfdev=1
        cmdreg=0x0087, statreg=0x0210, cachelnsz=0 (dwords)
        lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
        powerspec 2  supports D0 D3  current D0
        map[20]: type 4, range 32, base 0000e000, size  4, enabled
found-> vendor=0x1106, dev=0x0571, revid=0x06
        bus=0, slot=17, func=1
        class=01-01-8a, hdrtype=0x00, mfdev=0
        cmdreg=0x0007, statreg=0x0290, cachelnsz=0 (dwords)
        lattimer=0x20 (960 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
        powerspec 2  supports D0 D3  current D0
pcib1: <PCI-PCI bridge> at device 1.0 on pci0
pcib1:   secondary bus     1
pcib1:   subordinate bus   1
pcib1:   I/O decode        0xf000-0xfff
pcib1:   memory decode     0xd0000000-0xd7ffffff
pcib1:   prefetched decode 0xfff00000-0xfffff
pci1: <PCI bus> on pcib1
pci1: physical bus=1
        map[10]: type 1, range 32, base d0000000, size 26, enabled
pcib1: device (null) requested decoded memory range 0xd0000000-0xd3ffffff
found-> vendor=0x5333, dev=0x8a13, revid=0x02
        bus=1, slot=0, func=0
        class=03-00-00, hdrtype=0x00, mfdev=0
        cmdreg=0x0007, statreg=0x0210, cachelnsz=0 (dwords)
        lattimer=0x20 (960 ns), mingnt=0x04 (1000 ns), maxlat=0xff (63750 ns)
        powerspec 1  supports D0 D3  current D0
pci1: <display, VGA> at device 0.0 (no driver attached)
rl0: Reserved 0x80 bytes for rid 0x10 type 4 at 0xc000
rl0: <RealTek 8129 10/100BaseTX> port 0xc000-0xc07f mem 0xda401000-0xda40107f irq 16 at device 9.0 on pci0
miibus0: <MII bus> on rl0
rlphy0: <RealTek internal media interface> on miibus0
rlphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
rl0: bpf attached
rl0: Ethernet address: 00:80:c6:f9:08:58
rl0: [GIANT-LOCKED]
pci0: <display, VGA> at device 10.0 (no driver attached)
pcm0: <CMedia CMI8738> port 0xc800-0xc8ff irq 17 at device 14.0 on pci0
pcm0: Reserved 0x100 bytes for rid 0x10 type 4 at 0xc800
pcm0: [MPSAFE]
pcm0: sndbuf_setmap 1f45c000, 4000; 0xd544e000 -> 1f45c000
pcm0: sndbuf_setmap 1f458000, 4000; 0xd5452000 -> 1f458000
atapci0: <CMD 649 UDMA100 controller> port 0xdc00-0xdc0f,0xd800-0xd803,0xd400-0xd407,0xd000-0xd003,0xcc00-0xcc07 irq 18 at device 15.0 on pci0
atapci0: Reserved 0x10 bytes for rid 0x20 type 4 at 0xdc00
atapci0: [MPSAFE]
atapci0: Reserved 0x8 bytes for rid 0x10 type 4 at 0xcc00
atapci0: Reserved 0x4 bytes for rid 0x14 type 4 at 0xd000
ata2: reset tp1 mask=03 ostat0=7f ostat1=7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2-slave:  stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata2: reset tp2 stat0=ff stat1=ff devices=0x0
ata2: at 0xcc00 on atapci0
ata2: [MPSAFE]
atapci0: Reserved 0x8 bytes for rid 0x18 type 4 at 0xd400
atapci0: Reserved 0x4 bytes for rid 0x1c type 4 at 0xd800
ata3: reset tp1 mask=03 ostat0=7f ostat1=7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-master: stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3-slave:  stat=0x7f err=0x7f lsb=0x7f msb=0x7f
ata3: reset tp2 stat0=ff stat1=ff devices=0x0
ata3: at 0xd400 on atapci0
ata3: [MPSAFE]
isab0: <PCI-ISA bridge> at device 17.0 on pci0
isa0: <ISA bus> on isab0
atapci1: <VIA 8233 UDMA100 controller> port 0xe000-0xe00f,0x376,0x170-0x177,0x3f6,0x1f0-0x1f7 at device 17.1 on pci0
atapci1: Reserved 0x10 bytes for rid 0x20 type 4 at 0xe000
atapci1: Reserved 0x8 bytes for rid 0x10 type 4 at 0x1f0
atapci1: Reserved 0x1 bytes for rid 0x14 type 4 at 0x3f6
ata0: reset tp1 mask=03 ostat0=50 ostat1=00
ata0-master: stat=0x50 err=0x01 lsb=0x00 msb=0x00
ata0-slave:  stat=0x00 err=0x01 lsb=0x00 msb=0x00
ata0: reset tp2 stat0=50 stat1=00 devices=0x1<ATA_MASTER>
ata0: at 0x1f0 irq 14 on atapci1
ata0: [MPSAFE]
atapci1: Reserved 0x8 bytes for rid 0x18 type 4 at 0x170
atapci1: Reserved 0x1 bytes for rid 0x1c type 4 at 0x376
ata1: reset tp1 mask=03 ostat0=50 ostat1=01
ata1-master: stat=0x00 err=0x01 lsb=0x14 msb=0xeb
ata1-slave:  stat=0x00 err=0x04 lsb=0x00 msb=0x00
ata1: reset tp2 stat0=00 stat1=00 devices=0x4<ATAPI_MASTER>
ata1: at 0x170 irq 15 on atapci1
ata1: [MPSAFE]
fdc0: <floppy drive controller> port 0x3f7,0x3f0-0x3f5 irq 6 drq 2 on acpi0
fdc0: FIFO enabled, 8 bytes threshold
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
sio0: irq maps: 0x4041 0x4051 0x4041 0x4041
sio0 port 0x3f8-0x3ff irq 4 on acpi0
sio0: type 16550A, console
sio1: irq maps: 0x4041 0x4049 0x4041 0x4041
sio1 port 0x2f8-0x2ff irq 3 on acpi0
sio1: type 16550A
unknown: not probed (disabled)
ppc0: using extended I/O port range
ppc0: SPP
ppc0 port 0xf78-0xf7b,0xb78-0xb7b,0x778-0x77b,0x378-0x37f irq 7 on acpi0
ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
ppbus0: <Parallel port bus> on ppc0
plip0: <PLIP network interface> on ppbus0
plip0: bpf attached
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
ppi0: <Parallel I/O> on ppbus0
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
unknown: not probed (disabled)
ata: ata0 already exists; skipping it
ata: ata1 already exists; skipping it
fdc: fdc0 already exists; skipping it
ppc: ppc0 already exists; skipping it
sc: sc0 already exists; skipping it
sio: sio0 already exists; skipping it
sio: sio1 already exists; skipping it
vga: vga0 already exists; skipping it
Trying Read_Port at 203
Trying Read_Port at 243
Trying Read_Port at 283
Trying Read_Port at 2c3
Trying Read_Port at 303
Trying Read_Port at 343
Trying Read_Port at 383
Trying Read_Port at 3c3
isa_probe_children: disabling PnP devices
isa_probe_children: probing non-PnP devices
pmtimer0 on isa0
orm0: <ISA Option ROMs> at iomem 0xc8000-0xcffff,0xc0000-0xc7fff on isa0
sc0: <System console> on isa0
sc0: VGA <16 virtual consoles, flags=0x0>
sc0: fb0, kbd0, terminal emulator: sc (syscons terminal)
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
fb0: vga0, vga, type:VGA (5), flags:0x7007f
fb0: port:0x3c0-0x3df, crtc:0x3d4, mem:0xa0000 0x20000
fb0: init mode:24, bios mode:3, current mode:24
fb0: window:0xc00b8000 size:32k gran:32k, buf:0 size:32k
VGA parameters upon power-up
50 18 10 00 00 00 03 00 02 67 5f 4f 50 82 55 81 
bf 1f 00 4f 0e 0f 00 00 07 80 9c 8e 8f 28 1f 96 
b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 
3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
VGA parameters in BIOS for mode 24
50 18 10 00 10 00 03 00 02 67 5f 4f 50 82 55 81 
bf 1f 00 4f 0d 0e 00 00 00 00 9c 8e 8f 28 1f 96 
b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 
3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
EGA/VGA parameters to be used for mode 24
50 18 10 00 10 00 03 00 02 67 5f 4f 50 82 55 81 
bf 1f 00 4f 0d 0e 00 00 00 00 9c 8e 8f 28 1f 96 
b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 
3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
adv0: not probed (disabled)
aha0: not probed (disabled)
aic0: not probed (disabled)
atkbdc0: <Keyboard controller (i8042)> at port 0x64,0x60 on isa0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
kbd0: atkbd0, generic (0), config:0x0, flags:0x3f0000
atkbd0: [GIANT-LOCKED]
psm0: current command byte:0067
kbdc: TEST_AUX_PORT status:0000
kbdc: RESET_AUX return code:00fe
kbdc: RESET_AUX return code:00fe
kbdc: RESET_AUX return code:00fe
kbdc: DIAGNOSE status:0055
kbdc: TEST_KBD_PORT status:0000
psm0: failed to reset the aux device.
bt0: not probed (disabled)
cs0: not probed (disabled)
ed0: not probed (disabled)
fe0: not probed (disabled)
ie0: not probed (disabled)
lnc0: not probed (disabled)
pcic0 failed to probe at port 0x3e0 iomem 0xd0000 on isa0
pcic1: not probed (disabled)
sio2: not probed (disabled)
sio3: not probed (disabled)
sn0: not probed (disabled)
vt0: not probed (disabled)
isa_probe_children: probing PnP devices
Device configuration finished.
procfs registered
Timecounter "TSC" frequency 876397877 Hz quality -100
Timecounters tick every 10.000 msec
lo0: bpf attached
ata0-master: pio=0x0c wdma=0x22 udma=0x45 cable=80pin
ata0-master: setting PIO4 on VIA 8233 chip
ata0-master: setting UDMA100 on VIA 8233 chip
ad0: <QUANTUM FIREBALLP AS40.0/A1Y.1500> ATA-5 disk at ata0-master
ad0: 39203MB (80288480 sectors), 79651 C, 16 H, 63 S, 512 B
ad0: 16 secs/int, 1 depth queue, UDMA100
GEOM: new disk ad0
ata1-master: pio=0x0c wdma=0x22 udma=0xffffffff cable=40pin
ATAPI_RESET time = 60us
[0] f:00 typ:165 s(CHS):0/1/1 e(CHS):260/254/63 s:63 l:4192902
[1] f:00 typ:165 s(CHS):261/0/1 e(CHS):521/254/63 s:4192965 l:4192965
[2] f:00 typ:165 s(CHS):522/0/1 e(CHS):782/254/63 s:8385930 l:4192965
[3] f:80 typ:165 s(CHS):783/0/1 e(CHS):1023/254/63 s:12578895 l:67697910
GEOM: Configure ad0s1, start 32256 length 2146765824 end 2146798079
GEOM: Configure ad0s2, start 2146798080 length 2146798080 end 4293596159
GEOM: Configure ad0s3, start 4293596160 length 2146798080 end 6440394239
GEOM: Configure ad0s4, start 6440394240 length 34661329920 end 41101724159
ata1-master: setting PIO4 on VIA 8233 chip
GEOM: Configure ad0s1a, start 0 length 167772160 end 167772159
GEOM: Configure ad0s1c, start 0 length 2146765824 end 2146765823
GEOM: Configure ad0s1e, start 167772160 length 1978993664 end 2146765823
acd0: <Compaq CRD-8322B/1.06> CDROM drive at ata1 as master
acd0: read 5500KB/s (5500KB/s), 128KB buffer, PIO4
acd0: Reads: CDR, CDRW, CDDA stream, packet
acd0: Writes:
acd0: Audio: play, 255 volume levels
acd0: Mechanism: ejectable tray, unlocked, lock protected
acd0: Medium: no/blank disc
SMP: AP CPU #1 Launched!
cpu1 AP:
     ID: 0x01000000   VER: 0x00040011 LDR: 0x02000000 DFR: 0x0fffffff
  lint0: 0x00010700 lint1: 0x00010400 TPR: 0x00000000 SVR: 0x000001ff
ioapic0: routing intpin 1 (ISA IRQ 1) to cluster 0
ioapic0: routing intpin 3 (ISA IRQ 3) to cluster 0
ioapic0: routing intpin 4 (ISA IRQ 4) to cluster 0
ioapic0: routing intpin 6 (ISA IRQ 6) to cluster 0
ioapic0: routing intpin 7 (ISA IRQ 7) to cluster 0
ioapic0: routing intpin 8 (ISA IRQ 8) to cluster 0
ioapic0: routing intpin 9 (ISA IRQ 9) to cluster 0
ioapic0: routing intpin 13 (ISA IRQ 13) to cluster 0
ioapic0: routing intpin 14 (ISA IRQ 14) to cluster 0
ioapic0: routing intpin 15 (ISA IRQ 15) to cluster 0
ioapic0: routing intpin 16 (PCI IRQ 16) to cluster 0
ioapic0: routing intpin 17 (PCI IRQ 17) to cluster 0
ioapic0: routing intpin 18 (PCI IRQ 18) to cluster 0
GEOM: Configure ad0s2a, start 0 length 167772160 end 167772159
GEOM: Configure ad0s2c, start 0 length 2146798080 end 2146798079
GEOM: Configure ad0s2e, start 167772160 length 1979025920 end 2146798079
GEOM: Configure ad0s3a, start 0 length 167772160 end 167772159
GEOM: Configure ad0s3c, start 0 length 2146798080 end 2146798079
GEOM: Configure ad0s3e, start 167772160 length 1979025920 end 2146798079
GEOM: Configure ad0s4a, start 0 length 167772160 end 167772159
GEOM: Configure ad0s4b, start 167772160 length 1073741824 end 1241513983
GEOM: Configure ad0s4c, start 0 length 34661329920 end 34661329919
GEOM: Configure ad0s4e, start 1241513984 length 1978662912 end 3220176895
GEOM: Configure ad0s4g, start 3220176896 length 2147483648 end 5367660543
GEOM: Configure ad0s4h, start 5367660544 length 29293669376 end 34661329919
Mounting root from ufs:/dev/ad0s4a
start_init: trying /sbin/init
Pre-seeding PRNG: kickstart.
Loading configuration files.
Entropy harvesting: interrupts ethernet point_to_point kickstart.
swapon: adding /dev/ad0s4b as swap device
Starting file system checks:
/dev/ad0s1a: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s1a: clean, 110384 free (1184 frags, 13650 blocks, 0.7% fragmentation)
/dev/ad0s1e: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s1e: clean, 1128055 free (29175 frags, 137360 blocks, 1.6% fragmentation)
/dev/ad0s2a: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s2a: clean, 111586 free (298 frags, 13911 blocks, 0.2% fragmentation)
/dev/ad0s2e: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s2e: clean, 932696 free (7984 frags, 115589 blocks, 0.4% fragmentation)
/dev/ad0s3a: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s3a: clean, 42892 free (1268 frags, 5203 blocks, 0.8% fragmentation)
/dev/ad0s3e: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s3e: clean, 990991 free (14519 frags, 122059 blocks, 0.8% fragmentation)
/dev/ad0s4a: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s4a: clean, 52152 free (1984 frags, 6271 blocks, 1.2% fragmentation)
/dev/ad0s4e: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s4e: clean, 963687 free (22791 frags, 117612 blocks, 1.2% fragmentation)
/dev/ad0s4h: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s4h: clean, 9506741 free (301141 frags, 1150700 blocks, 1.1% fragmentation)
/dev/ad0s4g: FILE SYSTEM CLEAN; SKIPPING CHECKS
/dev/ad0s4g: clean, 1528937 free (1129 frags, 190976 blocks, 0.1% fragmentation)
Setting hostname: freebeast.catwhisker.org.
rl0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> mtu 1500
        options=8<VLAN_MTU>
        inet 172.16.8.10 netmask 0xffffff00 broadcast 172.16.8.255
        inet6 fe80::280:c6ff:fef9:858%rl0 prefixlen 64 tentative scopeid 0x1 
        ether 00:80:c6:f9:08:58
        media: Ethernet autoselect (100baseTX <full-duplex>)
        status: active
lo0: flags=8049<UP,LOOPBACK,RUNNING,MULTICAST> mtu 16384
        inet 127.0.0.1 netmask 0xff000000 
        inet6 ::1 prefixlen 128 
        inet6 fe80::1%lo0 prefixlen 64 scopeid 0x3 
add net default: gateway 172.16.8.1
Additional routing options:.
Starting devd.
Mounting NFS file systems:.
Starting syslogd.
Aug  8 11:36:17 freebeast syslogd: kernel boot file is /boot/kernel/kernel
Setting date via ntp.
Looking for host 172.16.8.12 and service ntp
host found : pogo.catwhisker.org
Looking for host 172.16.8.1 and service ntp
host found : janus.catwhisker.orgE
Looking for hoxst 172.16.8.12 apnd service ntp
ehost found : pogno.catwhisker.orgs
ive timeout(9) function: 0xc05df89c(0xc1a4b800) 0.006611734 s
 8 Aug 11:36:22 ntpdate[294]: adjust time server 172.16.8.1 offset -0.252324 sec
NFS access cache time=2
module_register: module g_md already exists!
Module g_md failed to register: 17
can't re-use a leaf (mddebug)!
ad0: WARNING - WRITE_DMA interrupt was seen but timeout fired LBA=18969503
Expensive timeout(9) function: 0xc043cda4(0xc1bafca8) 0.087799366 s
rl0: watchdog timeout
ad0: WARNING - WRITE_DMA interrupt was seen but timeout fired LBA=18969503
ad0: WARNING - WRITE_DMA interrupt was seen but taskqueue stalled LBA=18969503
ad0: TIMEOUT - WRITE_DMA retrying (2 retries left) LBA=18969519
ata0: reiniting channel ..
ata0: reset tp1 mask=03 ostat0=50 ostat1=00
ad0: stat=0x50 err=0x01 lsb=0x00 msb=0x00
ata0-slave:  stat=0x00 err=0x01 lsb=0x00 msb=0x00
ata0: reset tp2 stat0=50 stat1=00 devices=0x1<ATA_MASTER>
ata0: resetting done ..
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ata0: device config done ..
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt
ad0: FAILURE - ATA_IDENTIFY no interrupt


That last line repeated; I hit ^S to stop the spewing so I could capture
the above & send it before the scroll buffer overflowed.

What may I do to help debug this?

Thanks,
david
-- 
David H. Wolfskill				david_at_catwhisker.org
I do not "unsubscribe" from email "services" to which I have not explicitly
subscribed.  Rather, I block spammers' access to SMTP servers I control,
and encourage others who are in a position to do so to do likewise.
Received on Sun Aug 08 2004 - 16:49:43 UTC

This archive was generated by hypermail 2.4.0 : Wed May 19 2021 - 11:38:05 UTC