From owner-freebsd-standards@FreeBSD.ORG Thu Jul 31 16:30:04 2008 Return-Path: Delivered-To: freebsd-standards@hub.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 61AE71065682 for ; Thu, 31 Jul 2008 16:30:04 +0000 (UTC) (envelope-from gnats@FreeBSD.org) Received: from freefall.freebsd.org (freefall.freebsd.org [IPv6:2001:4f8:fff6::28]) by mx1.freebsd.org (Postfix) with ESMTP id 40F428FC13 for ; Thu, 31 Jul 2008 16:30:04 +0000 (UTC) (envelope-from gnats@FreeBSD.org) Received: from freefall.freebsd.org (gnats@localhost [127.0.0.1]) by freefall.freebsd.org (8.14.2/8.14.2) with ESMTP id m6VGU46A055199 for ; Thu, 31 Jul 2008 16:30:04 GMT (envelope-from gnats@freefall.freebsd.org) Received: (from gnats@localhost) by freefall.freebsd.org (8.14.2/8.14.1/Submit) id m6VGU4OI055196; Thu, 31 Jul 2008 16:30:04 GMT (envelope-from gnats) Resent-Date: Thu, 31 Jul 2008 16:30:04 GMT Resent-Message-Id: <200807311630.m6VGU4OI055196@freefall.freebsd.org> Resent-From: FreeBSD-gnats-submit@FreeBSD.org (GNATS Filer) Resent-To: freebsd-standards@FreeBSD.org Resent-Reply-To: FreeBSD-gnats-submit@FreeBSD.org, Konstantin Lebedev Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 17CDE106567C for ; Thu, 31 Jul 2008 16:20:00 +0000 (UTC) (envelope-from nobody@FreeBSD.org) Received: from www.freebsd.org (www.freebsd.org [IPv6:2001:4f8:fff6::21]) by mx1.freebsd.org (Postfix) with ESMTP id F27548FC13 for ; Thu, 31 Jul 2008 16:19:59 +0000 (UTC) (envelope-from nobody@FreeBSD.org) Received: from www.freebsd.org (localhost [127.0.0.1]) by www.freebsd.org (8.14.2/8.14.2) with ESMTP id m6VGJxl8077745 for ; Thu, 31 Jul 2008 16:19:59 GMT (envelope-from nobody@www.freebsd.org) Received: (from nobody@localhost) by www.freebsd.org (8.14.2/8.14.1/Submit) id m6VGJxrU077743; Thu, 31 Jul 2008 16:19:59 GMT (envelope-from nobody) Message-Id: <200807311619.m6VGJxrU077743@www.freebsd.org> Date: Thu, 31 Jul 2008 16:19:59 GMT From: Konstantin Lebedev To: freebsd-gnats-submit@FreeBSD.org X-Send-Pr-Version: www-3.1 Cc: Subject: standards/126142: READ DMA faults, device detaching X-BeenThere: freebsd-standards@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Standards compliance List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 31 Jul 2008 16:30:04 -0000 >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 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: pcibus 0 on motherboard Jul 31 05:33:40 melchior kernel: pir0: on motherboard Jul 31 05:33:40 melchior kernel: pci0: on pcib0 Jul 31 05:33:40 melchior kernel: agp0: on hostb0 Jul 31 05:33:40 melchior kernel: pcib1: at device 1.0 on pci0 Jul 31 05:33:40 melchior kernel: pci1: on pcib1 Jul 31 05:33:40 melchior kernel: vgapci0: port 0x9000-0x90ff mem 0xe2000000-0xe2ffffff,0xe1000000-0xe1000fff irq 11 at device 0.0 on pci1 Jul 31 05:33:40 melchior kernel: fxp0: port 0xa000-0xa01f mem 0xe5500000-0xe5500fff,0xe5400000-0xe54fffff irq 11 at device 4.0 on pci0 Jul 31 05:33:40 melchior kernel: miibus0: on fxp0 Jul 31 05:33:40 melchior kernel: inphy0: 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: at device 7.0 on pci0 Jul 31 05:33:40 melchior kernel: isa0: on isab0 Jul 31 05:33:40 melchior kernel: atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xf000-0xf00f at device 7.1 on pci0 Jul 31 05:33:40 melchior kernel: ata0: on atapci0 Jul 31 05:33:40 melchior kernel: ata0: [ITHREAD] Jul 31 05:33:40 melchior kernel: ata1: on atapci0 Jul 31 05:33:40 melchior kernel: ata1: [ITHREAD] Jul 31 05:33:40 melchior kernel: pci0: at device 7.2 (no driver attached) Jul 31 05:33:40 melchior kernel: pci0: at device 7.3 (no driver attached) Jul 31 05:33:40 melchior kernel: atapci1: 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: on atapci1 Jul 31 05:33:40 melchior kernel: ata2: [ITHREAD] Jul 31 05:33:40 melchior kernel: ata3: on atapci1 Jul 31 05:33:40 melchior kernel: ata3: [ITHREAD] Jul 31 05:33:40 melchior kernel: pci0: 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: at iomem 0xc0000-0xc7fff pnpid ORM0000 on isa0 Jul 31 05:33:40 melchior kernel: atkbdc0: at port 0x60,0x64 on isa0 Jul 31 05:33:40 melchior kernel: atkbd0: 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: 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: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 Jul 31 05:33:40 melchior kernel: unknown: can't assign resources (port) Jul 31 05:33:40 melchior kernel: unknown: can't assign resources (memory) Jul 31 05:33:40 melchior kernel: unknown: can't assign resources (port) Jul 31 05:33:40 melchior kernel: unknown: 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 at ata0-master UDMA33 Jul 31 05:33:40 melchior kernel: ad4: 476940MB at ata2-master SATA150 >How-To-Repeat: i don't know. >Fix: may be patch ata driver? >Release-Note: >Audit-Trail: >Unformatted: