From owner-freebsd-usb@FreeBSD.ORG Wed Aug 1 12:10:08 2007 Return-Path: Delivered-To: freebsd-usb@hub.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id E114B16A418 for ; Wed, 1 Aug 2007 12:10:07 +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 C659F13C48D for ; Wed, 1 Aug 2007 12:10:07 +0000 (UTC) (envelope-from gnats@FreeBSD.org) Received: from freefall.freebsd.org (gnats@localhost [127.0.0.1]) by freefall.freebsd.org (8.14.1/8.14.1) with ESMTP id l71CA78L031109 for ; Wed, 1 Aug 2007 12:10:07 GMT (envelope-from gnats@freefall.freebsd.org) Received: (from gnats@localhost) by freefall.freebsd.org (8.14.1/8.14.1/Submit) id l71CA7nR031108; Wed, 1 Aug 2007 12:10:07 GMT (envelope-from gnats) Date: Wed, 1 Aug 2007 12:10:07 GMT Message-Id: <200708011210.l71CA7nR031108@freefall.freebsd.org> To: freebsd-usb@FreeBSD.org From: Antonios Anastasiadis Cc: Subject: Re: usb/104830: [umass] system crashes when copying data to umass devices X-BeenThere: freebsd-usb@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list Reply-To: Antonios Anastasiadis List-Id: FreeBSD support for USB List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Wed, 01 Aug 2007 12:10:08 -0000 The following reply was made to PR usb/104830; it has been noted by GNATS. From: Antonios Anastasiadis To: bug-followup@FreeBSD.org, arundel@h3c.de Cc: Subject: Re: usb/104830: [umass] system crashes when copying data to umass devices Date: Wed, 01 Aug 2007 14:36:30 +0300 I have exactly the same problem when my usb hdd reaches almost full capacity. The dmesg fills with g_vfs_done() (see below) messages and then the system either locks up or reboots. It had occurred once that the filesystem was completely thrashed and I had to do an fsck -y and digg through lost+found for any surviving files. DMESG using FreeBSD -stable follows: Copyright (c) 1992-2007 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 is a registered trademark of The FreeBSD Foundation. FreeBSD 6.2-STABLE #1: Sun Jul 22 02:32:36 EEST 2007 root@arroyo.wasteland.awmn:/usr/obj/usr/src/sys/GENERIC ACPI APIC Table: Timecounter "i8254" frequency 1193182 Hz quality 0 CPU: Intel(R) Celeron(R) CPU 1.70GHz (1699.82-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0xf13 Stepping = 3 Features=0x3febfbff real memory = 803471360 (766 MB) avail memory = 772812800 (737 MB) ioapic0: Changing APIC ID to 1 ioapic0 irqs 0-23 on motherboard kbd1 at kbdmux0 ath_hal: 0.9.20.3 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413, RF5413) acpi0: on motherboard acpi0: Power Button (fixed) Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0 cpu0: on acpi0 acpi_throttle0: on cpu0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 agp0: mem 0xf0000000-0xf7ffffff,0xffa80000-0xffafffff irq 16 at device 2.0 on pci0 agp0: detected 892k stolen memory agp0: aperture size is 128M uhci0: port 0xe800-0xe81f irq 16 at device 29.0 on pci0 uhci0: [GIANT-LOCKED] usb0: on uhci0 usb0: USB revision 1.0 uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub0: 2 ports with 2 removable, self powered uhci1: port 0xe880-0xe89f irq 19 at device 29.1 on pci0 uhci1: [GIANT-LOCKED] usb1: on uhci1 usb1: USB revision 1.0 uhub1: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub1: 2 ports with 2 removable, self powered uhci2: port 0xec00-0xec1f irq 18 at device 29.2 on pci0 uhci2: [GIANT-LOCKED] usb2: on uhci2 usb2: USB revision 1.0 uhub2: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub2: 2 ports with 2 removable, self powered ehci0: mem 0xffa7fc00-0xffa7ffff irq 23 at device 29.7 on pci0 ehci0: [GIANT-LOCKED] usb3: EHCI version 1.0 usb3: companion controllers, 2 ports each: usb0 usb1 usb2 usb3: on ehci0 usb3: USB revision 2.0 uhub3: Intel EHCI root hub, class 9/0, rev 2.00/1.00, addr 1 uhub3: 6 ports with 6 removable, self powered uhub4: vendor 0x05e3 USB2.0 Hub, class 9/0, rev 2.00/7.02, addr 2 uhub4: single transaction translator uhub4: 4 ports with 4 removable, self powered umass0: vendor 0x04b4 Cypress AT2LP, rev 2.00/2.40, addr 3 pcib1: at device 30.0 on pci0 pci1: on pcib1 fxp0: port 0xdc00-0xdc3f mem 0xff8ff000-0xff8fffff irq 20 at device 8.0 on pci1 miibus0: on fxp0 inphy0: on miibus0 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp0: Ethernet address: 00:07:e9:b6:2a:1b isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xffa0-0xffaf at device 31.1 on pci0 ata0: on atapci0 ata1: on atapci0 pci0: at device 31.3 (no driver attached) pci0: at device 31.5 (no driver attached) sio0: configured irq 4 not in bitmap of probed irqs 0 sio0: port may not be enabled sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 sio0: type 16550A, console sio1: configured irq 3 not in bitmap of probed irqs 0 sio1: port may not be enabled sio1: <16550A-compatible COM port> port 0x2f8-0x2ff irq 3 on acpi0 sio1: type 16550A fdc0: port 0x3f0-0x3f1,0x3f2-0x3f3,0x3f4-0x3f5,0x3f7 irq 6 drq 2 on acpi0 fdc0: [FAST] fd0: <1440-KB 3.5" drive> on fdc0 drive 0 ppc0: port 0x378-0x37f irq 7 on acpi0 ppc0: Generic chipset (EPP/NIBBLE) in COMPATIBLE mode ppbus0: on ppc0 plip0: on ppbus0 lpt0: on ppbus0 lpt0: Interrupt-driven port ppi0: on ppbus0 pmtimer0 on isa0 atkbdc0: at port 0x60,0x64 on isa0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x100> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 Timecounter "TSC" frequency 1699816144 Hz quality 800 Timecounters tick every 1.000 msec ad0: 38166MB at ata0-master UDMA100 ad1: 194481MB at ata0-slave UDMA100 ad2: 190782MB at ata1-master UDMA100 umass1: JMicron USB to ATA/ATAPI Bridge, rev 2.00/1.00, addr 4 da0 at umass-sim0 bus 0 target 0 lun 0 da0: Fixed Direct Access SCSI-0 device da0: 40.000MB/s transfers da0: 190782MB (390721968 512 byte sectors: 255H 63S/T 24321C) da1 at umass-sim1 bus 1 target 0 lun 0 da1: Fixed Direct Access SCSI-2 device da1: 40.000MB/s transfers da1: 305245MB (625142448 512 byte sectors: 255H 63S/T 38913C) Trying to mount root from ufs:/dev/ad0s1a once the bug triggers, the dmesg floods with messages like these: Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=8804889317548032, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2425862682624, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=8804889317548032, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2425862682624, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=8804889317548032, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2425862682624, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=8804889317548032, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2425862682624, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=8804889317548032, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2425862682624, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=8804889317548032, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2425862682624, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419352709120, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2420919924736, length=16384)]error = 5 Jul 23 12:25:58 arroyo kernel: g_vfs_done():da1e[READ(offset=2419342194688, length=16384)]error = 5