Skip site navigation (1)Skip section navigation (2)
Date:      Thu, 31 Jul 2008 16:19:59 GMT
From:      Konstantin Lebedev <shinkei@yandex.ru>
To:        freebsd-gnats-submit@FreeBSD.org
Subject:   standards/126142: READ DMA faults, device detaching
Message-ID:  <200807311619.m6VGJxrU077743@www.freebsd.org>
Resent-Message-ID: <200807311630.m6VGU4OI055196@freefall.freebsd.org>

next in thread | raw e-mail | index | archive | help

>Number:         126142
>Category:       standards
>Synopsis:       READ DMA faults, device detaching
>Confidential:   no
>Severity:       critical
>Priority:       medium
>Responsible:    freebsd-standards
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          sw-bug
>Submitter-Id:   current-users
>Arrival-Date:   Thu Jul 31 16:30:03 UTC 2008
>Closed-Date:
>Last-Modified:
>Originator:     Konstantin Lebedev
>Release:        FreeBSD i386 7.0-p3
>Organization:
PeterHost.Ru
>Environment:
FreeBSD melchior.shinkei.ru 7.0-RELEASE-p3 FreeBSD 7.0-RELEASE-p3 #0: Fri Jul 18 19:11:26 MSD 2008     root@melchior.shinkei.ru:/usr/src/sys/i386/compile/SANA  i386

>Description:
My machine stops on reading from HDD and reboot after some time.

My dmesg (error and after boot):

Jul 31 05:29:18 melchior kernel: ad4: TIMEOUT - READ_DMA48 retrying (1 retry left) LBA=677896144
Jul 31 05:29:18 melchior kernel: interrupt storm detected on "irq10:"; throttling interrupt source
Jul 31 05:29:22 melchior last message repeated 4 times
Jul 31 05:29:23 melchior kernel: ad4: TIMEOUT - READ_DMA48 retrying (0 retries left) LBA=677896144
Jul 31 05:29:59 melchior kernel: ad4: FAILURE - device detached
Jul 31 05:29:59 melchior kernel: subdisk4: detached
Jul 31 05:29:59 melchior kernel: ad4: detached
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347082817536, length=131072)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347082817536, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347082833920, length=131072)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=352288047104, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502459904, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=436464951296, length=2048)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347082817536, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502476288, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083194368, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502492672, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083210752, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502492672, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083210752, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502509056, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083227136, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502509056, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083243520, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502525440, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083243520, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=316829007872, length=131072)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502541824, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083259904, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=316829007872, length=131072)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502541824, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083259904, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502558208, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083276288, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=316829007872, length=131072)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=436462970880, length=2048)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=436465528832, length=2048)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=436465938432, length=2048)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=436466198528, length=2048)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502574592, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083292672, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=341502574592, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=347083292672, length=32768)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=316829007872, length=16384)]error = 6
Jul 31 05:29:59 melchior kernel: g_vfs_done():ad4a[READ(offset=316829024256, length=131072)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=341502590976, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083309056, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829007872, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=341502590976, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083325440, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829024256, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=341502607360, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083325440, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829024256, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=341502623744, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083341824, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829040640, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=341502623744, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083341824, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829057024, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=341502640128, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083358208, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829057024, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=437813516288, length=8192)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=437813516288, length=8192)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347083374592, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829073408, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347084111872, length=32768)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829089792, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=347084128256, length=16384)]error = 6
Jul 31 05:30:00 melchior kernel: g_vfs_done():ad4a[READ(offset=316829089792, length=32768)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=347084144640, length=16384)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=316829106176, length=16384)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=347084144640, length=32768)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=316829106176, length=32768)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=347084161024, length=16384)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=316829122560, length=32768)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=347084161024, length=32768)]error = 6
Jul 31 05:30:01 melchior kernel: g_vfs_done():ad4a[READ(offset=316829138944, length=16384)]error = 6
Jul 31 05:33:40 melchior syslogd: kernel boot file is /boot/kernel/kernel
Jul 31 05:33:40 melchior kernel: Copyright (c) 1992-2008 The FreeBSD Project.
Jul 31 05:33:40 melchior kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
Jul 31 05:33:40 melchior kernel: The Regents of the University of California. All rights reserved.
Jul 31 05:33:40 melchior kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
Jul 31 05:33:40 melchior kernel: FreeBSD 7.0-RELEASE-p3 #0: Fri Jul 18 19:11:26 MSD 2008
Jul 31 05:33:40 melchior kernel: root@melchior.shinkei.ru:/usr/src/sys/i386/compile/SANA
Jul 31 05:33:40 melchior kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
Jul 31 05:33:40 melchior kernel: CPU: Pentium III/Pentium III Xeon/Celeron (501.14-MHz 686-class CPU)
Jul 31 05:33:40 melchior kernel: Origin = "GenuineIntel"  Id = 0x673  Stepping = 3
Jul 31 05:33:40 melchior kernel: Features=0x387f9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,PN,MMX,FXSR,SSE>
Jul 31 05:33:40 melchior kernel: real memory  = 268369920 (255 MB)
Jul 31 05:33:40 melchior kernel: avail memory = 253034496 (241 MB)
Jul 31 05:33:40 melchior kernel: kbd1 at kbdmux0
Jul 31 05:33:40 melchior kernel: ACPI disabled by blacklist.  Contact your BIOS vendor.
Jul 31 05:33:40 melchior kernel: ACPI: Try disabling either ACPI or apic support.
Jul 31 05:33:40 melchior kernel: cpu0 on motherboard
Jul 31 05:33:40 melchior kernel: pcib0: <Intel 82443BX (440 BX) host to PCI bridge> pcibus 0 on motherboard
Jul 31 05:33:40 melchior kernel: pir0: <PCI Interrupt Routing Table: 7 Entries> on motherboard
Jul 31 05:33:40 melchior kernel: pci0: <PCI bus> on pcib0
Jul 31 05:33:40 melchior kernel: agp0: <Intel 82443BX (440 BX) host to PCI bridge> on hostb0
Jul 31 05:33:40 melchior kernel: pcib1: <PCI-PCI bridge> at device 1.0 on pci0
Jul 31 05:33:40 melchior kernel: pci1: <PCI bus> on pcib1
Jul 31 05:33:40 melchior kernel: vgapci0: <VGA-compatible display> port 0x9000-0x90ff mem 0xe2000000-0xe2ffffff,0xe1000000-0xe1000fff irq 11 at device 0.0 on pci1
Jul 31 05:33:40 melchior kernel: fxp0: <Intel 82558 Pro/100 Ethernet> port 0xa000-0xa01f mem 0xe5500000-0xe5500fff,0xe5400000-0xe54fffff irq 11 at device 4.0 on pci0
Jul 31 05:33:40 melchior kernel: miibus0: <MII bus> on fxp0
Jul 31 05:33:40 melchior kernel: inphy0: <i82555 10/100 media interface> PHY 1 on miibus0
Jul 31 05:33:40 melchior kernel: inphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
Jul 31 05:33:40 melchior kernel: fxp0: Ethernet address: 00:10:dc:26:51:1e
Jul 31 05:33:40 melchior kernel: fxp0: [ITHREAD]
Jul 31 05:33:40 melchior kernel: isab0: <PCI-ISA bridge> at device 7.0 on pci0
Jul 31 05:33:40 melchior kernel: isa0: <ISA bus> on isab0
Jul 31 05:33:40 melchior kernel: atapci0: <Intel PIIX4 UDMA33 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xf000-0xf00f at device 7.1 on pci0
Jul 31 05:33:40 melchior kernel: ata0: <ATA channel 0> on atapci0
Jul 31 05:33:40 melchior kernel: ata0: [ITHREAD]
Jul 31 05:33:40 melchior kernel: ata1: <ATA channel 1> on atapci0
Jul 31 05:33:40 melchior kernel: ata1: [ITHREAD]
Jul 31 05:33:40 melchior kernel: pci0: <serial bus, USB> at device 7.2 (no driver attached)
Jul 31 05:33:40 melchior kernel: pci0: <bridge> at device 7.3 (no driver attached)
Jul 31 05:33:40 melchior kernel: atapci1: <AcerLabs M5281 SATA150 controller> port 0xa800-0xa807,0xac00-0xac03,0xb000-0xb007,0xb400-0xb403,0xb800-0xb80f irq 10 at device 20.0 on pci0
Jul 31 05:33:40 melchior kernel: atapci1: [ITHREAD]
Jul 31 05:33:40 melchior kernel: ata2: <ATA channel 0> on atapci1
Jul 31 05:33:40 melchior kernel: ata2: [ITHREAD]
Jul 31 05:33:40 melchior kernel: ata3: <ATA channel 1> on atapci1
Jul 31 05:33:40 melchior kernel: ata3: [ITHREAD]
Jul 31 05:33:40 melchior kernel: pci0: <mass storage> at device 20.1 (no driver attached)
Jul 31 05:33:40 melchior kernel: pmtimer0 on isa0
Jul 31 05:33:40 melchior kernel: orm0: <ISA Option ROM> at iomem 0xc0000-0xc7fff pnpid ORM0000 on isa0
Jul 31 05:33:40 melchior kernel: atkbdc0: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0
Jul 31 05:33:40 melchior kernel: atkbd0: <AT Keyboard> irq 1 on atkbdc0
Jul 31 05:33:40 melchior kernel: kbd0 at atkbd0
Jul 31 05:33:40 melchior kernel: atkbd0: [GIANT-LOCKED]
Jul 31 05:33:40 melchior kernel: atkbd0: [ITHREAD]
Jul 31 05:33:40 melchior kernel: sc0: <System console> at flags 0x100 on isa0
Jul 31 05:33:40 melchior kernel: sc0: VGA <16 virtual consoles, flags=0x300>
Jul 31 05:33:40 melchior kernel: sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
Jul 31 05:33:40 melchior kernel: sio0: type 16550A
Jul 31 05:33:40 melchior kernel: sio0: [FILTER]
Jul 31 05:33:40 melchior kernel: sio1: configured irq 3 not in bitmap of probed irqs 0
Jul 31 05:33:40 melchior kernel: sio1: port may not be enabled
Jul 31 05:33:40 melchior kernel: vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
Jul 31 05:33:40 melchior kernel: unknown: <PNP0303> can't assign resources (port)
Jul 31 05:33:40 melchior kernel: unknown: <PNP0c01> can't assign resources (memory)
Jul 31 05:33:40 melchior kernel: unknown: <PNP0a03> can't assign resources (port)
Jul 31 05:33:40 melchior kernel: unknown: <PNP0501> can't assign resources (port)
Jul 31 05:33:40 melchior kernel: Timecounter "TSC" frequency 501139784 Hz quality 800
Jul 31 05:33:40 melchior kernel: Timecounters tick every 1.000 msec
Jul 31 05:33:40 melchior kernel: ipfw2 (+ipv6) initialized, divert enabled, rule-based forwarding enabled, default to accept, logging limited to 100 packets/entry by default
Jul 31 05:33:40 melchior kernel: ad0: 19547MB <FUJITSU MPF3204AH 5C18> at ata0-master UDMA33
Jul 31 05:33:40 melchior kernel: ad4: 476940MB <WDC WD5000AACS-00ZUB0 01.01B01> at ata2-master SATA150

>How-To-Repeat:
i don't know.
>Fix:
may be patch ata driver?

>Release-Note:
>Audit-Trail:
>Unformatted:



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?200807311619.m6VGJxrU077743>