READ_DMA interrupt was seen but timeout fired LBA=####

David E. Cross crossd at cs.rpi.edu
Tue Aug 31 11:35:52 PDT 2004 

I searched the mailing list an didn't see anything listed for August, so I
thought I would write.

Upon switching to 5.3-BETA2 I see these a LOT on my IBM TP T30.  In fact
BETA2 panics shortly after boot, and once in DDB I can't actually do
anything ('panic' doesn't work, 'call boot(0)' doesn't work, eventually
DDB itself just locks).  Upgrading to RELENG_5 makes it a bit better, I
still see oodles of those messages and WRITE_DMA messages also, but it
doesn't panic.  Eventually everything will lock behind "ufs" in a wait
channel.  Booting to single-user seems to make it better (I can run
commands, etc and not get stuck in [ufs]).  ACPI doesn't seem to make a
difference.  Also, the GENERIC on the CD loader doesn't seem to exhibit
any of these problems.  Below is a copy of my DMESG; ideas?  Any
additional information required?

Aug 30 23:13:44  syslogd: kernel boot file is /boot/kernel/kernel
Aug 30 23:13:44  kernel: Copyright (c) 1992-2004 The FreeBSD Project.
Aug 30 23:13:44  kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989,
1991, 1992, 1993, 1994
Aug 30 23:13:44  kernel: The Regents of the University of California. All
rights reserved.
Aug 30 23:13:44  kernel: FreeBSD 5.3-BETA2 #1: Sat Aug 28 21:29:15 UTC
2004
Aug 30 23:13:44  kernel:
root at mack.dcsl.buffalo.edu:/usr/obj/usr/src/sys/GENERICAug 30 23:13:44
kernel: WARNING: WITNESS option enabled, expect reduced performance.
Aug 30 23:13:44  kernel: Timecounter "i8254" frequency 1193182 Hz quality
0
Aug 30 23:13:44  kernel: CPU: Mobile Intel(R) Pentium(R) 4 - M CPU 2.00GHz
(1998.31-MHz 686-class CPU)
Aug 30 23:13:44  kernel: Origin = "GenuineIntel"  Id = 0xf27  Stepping = 7
Aug 30 23:13:44  kernel:
Features=0xbfebf9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
Aug 30 23:13:44  kernel: real memory  = 267780096 (255 MB)
Aug 30 23:13:44  kernel: avail memory = 252379136 (240 MB)
Aug 30 23:13:44  kernel: npx0: [FAST]
Aug 30 23:13:44  kernel: npx0: <math processor> on motherboard
Aug 30 23:13:44  kernel: npx0: INT 16 interface
Aug 30 23:13:44  kernel: acpi0: <IBM TP-1I> on motherboard
Aug 30 23:13:44  kernel: acpi_ec_ecdt_probe: can't get handle
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.FDC_._INI] (Node 0xc15e6420), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__._INI] (Node 0xc15dab00), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BAT0._STA] (Node 0xc15dc6a0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0239: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BAT0._STA] (Node 0xc15dc6a0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BAT1._STA] (Node 0xc15dc520), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0239: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BAT1._STA] (Node 0xc15dc520), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BGID] (Node 0xc15e6560), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BINI] (Node 0xc15e6580), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BSTA] (Node 0xc15e65c0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.IDE0.SCND.MSTR._STA] (Node 0xc15e6480), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0239: *** Error: Method execution failed
[\_SB_.PCI0.IDE0.SCND.MSTR._STA] (Node 0xc15e6480), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BGID] (Node 0xc15e6560), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BINI] (Node 0xc15e6580), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BSTA] (Node 0xc15e65c0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.USB0.URTH.UNST._STA] (Node 0xc15e26e0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0239: *** Error: Method execution failed
[\_SB_.PCI0.USB0.URTH.UNST._STA] (Node 0xc15e26e0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0358: *** Error: Region EmbeddedControl(3)
has no
handler
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BGID] (Node 0xc15e6560), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BINI] (Node 0xc15e6580), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.PCI0.LPC_.EC__.BSTA] (Node 0xc15e65c0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-1303: *** Error: Method execution failed
[\_SB_.NEST._STA] (Node 0xc15e62e0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: ACPI-0239: *** Error: Method execution failed
[\_SB_.NEST._STA] (Node 0xc15e62e0), AE_NOT_EXIST
Aug 30 23:13:44  kernel: acpi0: Power Button (fixed)
Aug 30 23:13:44  kernel: acpi_ec0: <Embedded Controller: GPE 0x1c> port
0x66,0x62 on acpi0
Aug 30 23:13:44  kernel: Timecounter "ACPI-fast" frequency 3579545 Hz
quality 1000
Aug 30 23:13:44  kernel: acpi_timer0: <24-bit timer at 3.579545MHz> port
0x1008-0x100b on acpi0
Aug 30 23:13:44  kernel: cpu0: <ACPI CPU (3 Cx states)> on acpi0
Aug 30 23:13:44  kernel: acpi_tz0: <Thermal Zone> on acpi0
Aug 30 23:13:44  kernel: acpi_lid0: <Control Method Lid Switch> on acpi0
Aug 30 23:13:44  kernel: acpi_button0: <Sleep Button> on acpi0
Aug 30 23:13:44  kernel: pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on
acpi0
Aug 30 23:13:44  kernel: acpi link get: empty IRQ resource
Aug 30 23:13:44  kernel: pci0: <ACPI PCI bus> on pcib0
Aug 30 23:13:44  kernel: agp0: <Intel 82845 host to AGP bridge> mem
0xe0000000-0xe3ffffff at device 0.0 on pci0
Aug 30 23:13:44  kernel: pcib1: <ACPI PCI-PCI bridge> at device 1.0 on
pci0
Aug 30 23:13:44  kernel: pci1: <ACPI PCI bus> on pcib1
Aug 30 23:13:44  kernel: pci1: <display, VGA> at device 0.0 (no driver
attached)Aug 30 23:13:44  kernel: uhci0: <Intel 82801CA/CAM (ICH3) USB
controller USB-A>
port 0x1800-0x181f irq 11 at device 29.0 on pci0
Aug 30 23:13:44  kernel: uhci0: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: usb0: <Intel 82801CA/CAM (ICH3) USB controller
USB-A> on uhci0
Aug 30 23:13:44  kernel: usb0: USB revision 1.0
Aug 30 23:13:44  kernel: uhub0: Intel UHCI root hub, class 9/0, rev
1.00/1.00, addr 1
Aug 30 23:13:44  kernel: uhub0: 2 ports with 2 removable, self powered
Aug 30 23:13:44  kernel: uhci1: <Intel 82801CA/CAM (ICH3) USB controller
USB-B>
port 0x1820-0x183f irq 11 at device 29.1 on pci0
Aug 30 23:13:44  kernel: uhci1: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: usb1: <Intel 82801CA/CAM (ICH3) USB controller
USB-B> on uhci1
Aug 30 23:13:44  kernel: usb1: USB revision 1.0
Aug 30 23:13:44  kernel: uhub1: Intel UHCI root hub, class 9/0, rev
1.00/1.00, addr 1
Aug 30 23:13:44  kernel: uhub1: 2 ports with 2 removable, self powered
Aug 30 23:13:44  kernel: uhci2: <Intel 82801CA/CAM (ICH3) USB controller
USB-C>
port 0x1840-0x185f irq 11 at device 29.2 on pci0
Aug 30 23:13:44  kernel: uhci2: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: usb2: <Intel 82801CA/CAM (ICH3) USB controller
USB-C> on uhci2
Aug 30 23:13:44  kernel: usb2: USB revision 1.0
Aug 30 23:13:44  kernel: uhub2: Intel UHCI root hub, class 9/0, rev
1.00/1.00, addr 1
Aug 30 23:13:44  kernel: uhub2: 2 ports with 2 removable, self powered
Aug 30 23:13:44  kernel: pcib2: <ACPI PCI-PCI bridge> at device 30.0 on
pci0
Aug 30 23:13:44  kernel: pci2: <ACPI PCI bus> on pcib2
Aug 30 23:13:44  kernel: cbb0: <TI1520 PCI-CardBus Bridge> mem
0x50000000-0x50000fff irq 11 at device 0.0 on pci2
Aug 30 23:13:44  kernel: cardbus0: <CardBus bus> on cbb0
Aug 30 23:13:44  kernel: pccard0: <16-bit PCCard bus> on cbb0
Aug 30 23:13:44  kernel: cbb1: <TI1520 PCI-CardBus Bridge> mem
0x51000000-0x51000fff irq 5 at device 0.1 on pci2
Aug 30 23:13:44  kernel: cardbus1: <CardBus bus> on cbb1
Aug 30 23:13:44  kernel: pccard1: <16-bit PCCard bus> on cbb1
Aug 30 23:13:44  kernel: wi0: <Intersil Prism2.5> mem
0xf8000000-0xf8000fff irq
11 at device 2.0 on pci2
Aug 30 23:13:44  kernel: wi0: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: wi0: using RF:PRISM2.5 MAC:ISL3874A(Mini-PCI)
Aug 30 23:13:44  kernel: wi0: Intersil Firmware: Primary (1.1.0), Station
(1.4.9)
Aug 30 23:13:44  kernel: wi0: Ethernet address: 00:05:3c:04:7a:fc
Aug 30 23:13:44  kernel: wi0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps
Aug 30 23:13:44  kernel: fxp0: <Intel 82801CAM (ICH3) Pro/100 VE Ethernet>
port
0x8000-0x803f mem 0xd0200000-0xd0200fff irq 10 at device 8.0 on pci2
Aug 30 23:13:44  kernel: miibus0: <MII bus> on fxp0
Aug 30 23:13:44  kernel: inphy0: <i82562ET 10/100 media interface> on
miibus0
Aug 30 23:13:44  kernel: inphy0:  10baseT, 10baseT-FDX, 100baseTX,
100baseTX-FDX, auto
Aug 30 23:13:44  kernel: fxp0: Ethernet address: 00:09:6b:02:99:7f
Aug 30 23:13:44  kernel: fxp0: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: isab0: <PCI-ISA bridge> at device 31.0 on pci0
Aug 30 23:13:44  kernel: isa0: <ISA bus> on isab0
Aug 30 23:13:44  kernel: atapci0: <Intel ICH3 UDMA100 controller> port
0x1860-0x186f,0x376,0x170-0x177,0x3f6,0x1f0-0x1f7 at device 31.1 on pci0
Aug 30 23:13:44  kernel: ata0: channel #0 on atapci0
Aug 30 23:13:44  kernel: ata1: channel #1 on atapci0
Aug 30 23:13:44  kernel: pci0: <serial bus, SMBus> at device 31.3 (no
driver attached)
Aug 30 23:13:44  kernel: pci0: <multimedia, audio> at device 31.5 (no
driver attached)
Aug 30 23:13:44  kernel: pci0: <simple comms> at device 31.6 (no driver
attached)
Aug 30 23:13:44  kernel: atkbdc0: <Keyboard controller (i8042)> port
0x64,0x60 irq 1 on acpi0
Aug 30 23:13:44  kernel: atkbd0: <AT Keyboard> irq 1 on atkbdc0
Aug 30 23:13:44  kernel: kbd0 at atkbd0
Aug 30 23:13:44  kernel: atkbd0: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: psm0: <PS/2 Mouse> irq 12 on atkbdc0
Aug 30 23:13:44  kernel: psm0: [GIANT-LOCKED]
Aug 30 23:13:44  kernel: psm0: model Generic PS/2 mouse, device ID 0
Aug 30 23:13:44  kernel: fdc0: <floppy drive controller (FDE)> port
0x3f7,0x3f0-0x3f5 irq 6 drq 2 on acpi0
Aug 30 23:13:44  kernel: sio0 port 0x3f8-0x3ff irq 4 on acpi0
Aug 30 23:13:44  kernel: sio0: type 16550A
Aug 30 23:13:44  kernel: ppc0 port 0x3bc-0x3be irq 7 on acpi0
Aug 30 23:13:44  kernel: ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE
mode
Aug 30 23:13:44  kernel: ppbus0: <Parallel port bus> on ppc0
Aug 30 23:13:44  kernel: plip0: <PLIP network interface> on ppbus0
Aug 30 23:13:44  kernel: lpt0: <Printer> on ppbus0
Aug 30 23:13:44  kernel: lpt0: Interrupt-driven port
Aug 30 23:13:44  kernel: ppi0: <Parallel I/O> on ppbus0
Aug 30 23:13:44  kernel: sio1 port 0x2f8-0x2ff irq 3 drq 3 on acpi0
Aug 30 23:13:44  kernel: sio1: type 16550A
Aug 30 23:13:44  kernel: acpi_cmbat0: <Control Method Battery> on acpi0
Aug 30 23:13:44  kernel: acpi_acad0: <AC Adapter> on acpi0
Aug 30 23:13:44  kernel: orm0: <ISA Option ROMs> at iomem
0xdc000-0xdffff,0xd1000-0xd1fff,0xd0000-0xd0fff on isa0
Aug 30 23:13:44  kernel: pmtimer0 on isa0
Aug 30 23:13:44  kernel: sc0: <System console> at flags 0x100 on isa0
Aug 30 23:13:44  kernel: sc0: VGA <16 virtual consoles, flags=0x300>
Aug 30 23:13:44  kernel: vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem
0xa0000-0xbffff on isa0
Aug 30 23:13:44  kernel: Timecounter "TSC" frequency 1998312320 Hz quality
800
Aug 30 23:13:44  kernel: Timecounters tick every 10.000 msec
Aug 30 23:13:44  kernel: acpi_cpu: throttling enabled, 8 steps (100% to
12.5%),
currently 100.0%
Aug 30 23:13:44  kernel: ad0: 38154MB <IC25N040ATCS05-0/CS4OA61A>
[77520/16/63]
at ata0-master UDMA100
Aug 30 23:13:44  kernel: ATAPI_RESET time = 170us
Aug 30 23:13:44  kernel: ata1-slave: FAILURE - ATAPI_IDENTIFY timed out
Aug 30 23:13:44  kernel: ATAPI_RESET time = 330us
Aug 30 23:13:44  kernel: acd0: CDRW <UJDA730 DVD/CDRW/1.04> at ata1-master
UDMA33
Aug 30 23:13:44  kernel: Mounting root from ufs:/dev/ad0s3a
Aug 30 23:13:45  kernel: ad0: WARNING - READ_DMA interrupt was seen but
timeout


-- 
David E. Cross

More information about the freebsd-stable mailing list