Most recent kernel where this bug did not occur: ? Distribution: Mandriva 2006 Problem Description: When copying files (cca 100MB) to USB flash disk (mp3 player) with ehci_hcd loaded the data transfer freezes after a few megabytes. The freeze occurs almost always when the disk is mounted with -o sync (as I far as I remember the transfer was once succesful...), and always when mounted -o async. Without ehci_hcd it works well. The exact same problem is with 2.6.15.*. I think that in 2.6.13.* or so the errors tend to freeze a whole machine, not only the transfer. BTW another flash disk device (Kingston data traveler 256MB, usb 2.0) works fine with ehci_hcd. Steps to reproduce: Connect device, mount with -o async, start copying some files (100MB) to the device. Earlier or later the progressbar in mc just stops, dmesg shows errors.... complete dmesg: =================== Linux version 2.6.16-rc5-dirty (jara@megalit.sh.cvut.cz) (gcc version 4.0.1 (4.0.1-5mdk for Mandriva Linux release 2006.0)) #1 Tue Mar 7 00:00:23 CET 2006 BIOS-provided physical RAM map: BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) BIOS-e820: 0000000000100000 - 0000000037ff0000 (usable) BIOS-e820: 0000000037ff0000 - 0000000037ff8000 (ACPI data) BIOS-e820: 0000000037ff8000 - 0000000038000000 (ACPI NVS) BIOS-e820: 00000000fec00000 - 00000000fec01000 (reserved) BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved) BIOS-e820: 00000000fff80000 - 0000000100000000 (reserved) 895MB LOWMEM available. found SMP MP-table at 000fb990 On node 0 totalpages: 229360 DMA zone: 4096 pages, LIFO batch:0 DMA32 zone: 0 pages, LIFO batch:0 Normal zone: 225264 pages, LIFO batch:31 HighMem zone: 0 pages, LIFO batch:0 DMI 2.3 present. ACPI: RSDP (v000 AMI ) @ 0x000fa9f0 ACPI: RSDT (v001 AMIINT VIA_K7 0x00000010 MSFT 0x00000097) @ 0x37ff0000 ACPI: FADT (v001 AMIINT VIA_K7 0x00000011 MSFT 0x00000097) @ 0x37ff0030 ACPI: MADT (v001 AMIINT VIA_K7 0x00000009 MSFT 0x00000097) @ 0x37ff00c0 ACPI: DSDT (v001 VIA VIA_K7 0x00001000 MSFT 0x0100000d) @ 0x00000000 ACPI: PM-Timer IO Port: 0x808 ACPI: Local APIC address 0xfee00000 ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) Processor #0 6:6 APIC version 16 Using ACPI for processor (LAPIC) configuration information Intel MultiProcessor Specification v1.4 Virtual Wire compatibility mode. OEM ID: VIA Product ID: VT5440B APIC at: 0xFEE00000 I/O APIC #2 Version 3 at 0xFEC00000. Enabling APIC mode: Flat. Using 1 I/O APICs Processors: 1 Allocating PCI resources starting at 40000000 (gap: 38000000:c6c00000) Built 1 zonelists Kernel command line: BOOT_IMAGE=2616rc5-dirty root=342 splash=silent acpi=ht resume=/dev/hdb6 mapped APIC to ffffd000 (fee00000) mapped IOAPIC to ffffc000 (fec00000) Enabling fast FPU save and restore... done. Enabling unmasked SIMD FPU exception support... done. Initializing CPU#0 CPU 0 irqstacks, hard=c03ba000 soft=c03bb000 PID hash table entries: 4096 (order: 12, 65536 bytes) Detected 1670.640 MHz processor. Using pmtmr for high-res timesource Console: colour dummy device 80x25 Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Memory: 905460k/917440k available (1958k kernel code, 11488k reserved, 599k data, 208k init, 0k highmem) Checking if this processor honours the WP bit even in supervisor mode... Ok. Calibrating delay using timer specific routine.. 3345.96 BogoMIPS (lpj=6691925) Mount-cache hash table entries: 512 CPU: After generic identify, caps: 0383fbff c1c3fbff 00000000 00000000 00000000 00000000 00000000 CPU: After vendor identify, caps: 0383fbff c1c3fbff 00000000 00000000 00000000 00000000 00000000 CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) CPU: L2 Cache: 256K (64 bytes/line) CPU: After all inits, caps: 0383fbff c1c3fbff 00000000 00000020 00000000 00000000 00000000 Intel machine check architecture supported. Intel machine check reporting enabled on CPU#0. CPU: AMD Athlon(tm) XP 2000+ stepping 02 Checking 'hlt' instruction... OK. ExtINT not setup in hardware but reported by MP table ENABLING IO-APIC IRQs ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=0 pin2=0 checking if image is initramfs...it isn't (no cpio magic); looks like an initrd Freeing initrd memory: 315k freed NET: Registered protocol family 16 PCI: PCI BIOS revision 2.10 entry at 0xfdb11, last bus=1 PCI: Using configuration type 1 ACPI: Subsystem revision 20060127 ACPI: Interpreter disabled. Linux Plug and Play Support v0.97 (c) Adam Belay pnp: PnP ACPI: disabled PnPBIOS: Scanning system for PnP BIOS support... PnPBIOS: Found PnP BIOS installation structure at 0xc00f78f0 PnPBIOS: PnP BIOS version 1.0, entry 0xf0000:0x679b, dseg 0xf0000 PnPBIOS: Missing SMALL_TAG_ENDDEP tag PnPBIOS: Missing SMALL_TAG_ENDDEP tag PnPBIOS: Missing SMALL_TAG_ENDDEP tag PnPBIOS: Missing SMALL_TAG_ENDDEP tag PnPBIOS: Missing SMALL_TAG_ENDDEP tag PnPBIOS: 14 nodes reported by PnP BIOS; 14 recorded by driver PCI: Probing PCI hardware PCI: Probing PCI hardware (bus 00) Boot video device is 0000:01:00.0 PCI: Using IRQ router default [1106/3227] at 0000:00:11.0 PCI->APIC IRQ transform: 0000:00:0b.0[A] -> IRQ 18 PCI->APIC IRQ transform: 0000:00:0e.0[A] -> IRQ 17 PCI->APIC IRQ transform: 0000:00:10.0[A] -> IRQ 21 PCI->APIC IRQ transform: 0000:00:10.1[A] -> IRQ 21 PCI->APIC IRQ transform: 0000:00:10.2[B] -> IRQ 21 PCI->APIC IRQ transform: 0000:00:10.3[B] -> IRQ 21 PCI->APIC IRQ transform: 0000:00:10.4[C] -> IRQ 21 PCI->APIC IRQ transform: 0000:00:11.5[C] -> IRQ 22 PCI->APIC IRQ transform: 0000:01:00.0[A] -> IRQ 16 PCI: Bridge: 0000:00:01.0 IO window: disabled. MEM window: dde00000-dfefffff PREFETCH window: cdd00000-ddcfffff PCI: Setting latency timer of device 0000:00:01.0 to 64 apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac) audit: initializing netlink socket (disabled) audit(1141850343.024:1): initialized VFS: Disk quotas dquot_6.5.1 Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Initializing Cryptographic API io scheduler noop registered io scheduler anticipatory registered (default) io scheduler deadline registered io scheduler cfq registered 0000:00:10.3: uhci_check_and_reset_hc: legsup = 0xa000 0000:00:10.3: Performing full reset 0000:00:10.2: uhci_check_and_reset_hc: legsup = 0xa000 0000:00:10.2: Performing full reset 0000:00:10.1: uhci_check_and_reset_hc: legsup = 0xa000 0000:00:10.1: Performing full reset 0000:00:10.0: uhci_check_and_reset_hc: legsup = 0xa000 0000:00:10.0: Performing full reset PCI: Bypassing VIA 8237 APIC De-Assert Message vesafb: framebuffer at 0xd0000000, mapped to 0xf8880000, using 1875k, total 131072k vesafb: mode is 800x600x16, linelength=1600, pages=2 vesafb: protected mode interface info at c000:e340 vesafb: scrolling: redraw vesafb: Truecolor: size=0:5:6:5, shift=0:11:5:0 Console: switching to colour frame buffer device 100x37 fb0: VESA VGA frame buffer device isapnp: Scanning for PnP cards... isapnp: No Plug & Play device found Real Time Clock Driver v1.12ac PNP: PS/2 Controller [PNP0303,PNP0f13] at 0x60,0x64 irq 1,12 serio: i8042 AUX port at 0x60,0x64 irq 12 serio: i8042 KBD port at 0x60,0x64 irq 1 Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A 00:09: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A 00:0a: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A RAMDISK driver initialized: 16 RAM disks of 32000K size 1024 blocksize Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx VP_IDE: IDE controller at PCI slot 0000:00:0f.1 PCI: Via IRQ fixup for 0000:00:0f.1, from 255 to 0 VP_IDE: chipset revision 6 VP_IDE: not 100% native mode: will probe irqs later VP_IDE: VIA vt8237 (rev 00) IDE UDMA133 controller on pci0000:00:0f.1 ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:DMA, hdb:DMA ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:DMA, hdd:DMA Probing IDE interface ide0... hda: SAMSUNG SV3063H, ATA DISK drive hdb: WDC WD2000JB-00GVA0, ATA DISK drive ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 Probing IDE interface ide1... hdc: _NEC DVD_RW ND-3540A, ATAPI CD/DVD-ROM drive hdd: LITE-ON LTR-48246S, ATAPI CD/DVD-ROM drive ide1 at 0x170-0x177,0x376 on irq 15 hda: max request size: 128KiB hda: 59797584 sectors (30616 MB) w/426KiB Cache, CHS=59323/16/63, UDMA(100) hda: cache flushes not supported hda: hda1 hda2 hda3 < hda5 hda6 hda7 > hda1: <solaris: [s0] hda8 [s1] hda9 [s2] hda10 > hdb: max request size: 512KiB hdb: 390721968 sectors (200049 MB) w/8192KiB Cache, CHS=24321/255/63, UDMA(100) hdb: cache flushes supported hdb: hdb1 hdb2 hdb3 < hdb5 hdb6 hdb7 > hdb4 mice: PS/2 mouse device common for all mice md: md driver 0.90.3 MAX_MD_DEVS=256, MD_SB_DISKS=27 md: bitmap version 4.39 MC: drivers/edac/edac_mc.c version edac_mc Ver: 2.0.0 Mar 6 2006 NET: Registered protocol family 2 input: AT Translated Set 2 keyboard as /class/input/input0 IP route cache hash table entries: 32768 (order: 5, 131072 bytes) TCP established hash table entries: 131072 (order: 7, 524288 bytes) TCP bind hash table entries: 65536 (order: 6, 262144 bytes) TCP: Hash tables configured (established 131072 bind 65536) TCP reno registered TCP bic registered NET: Registered protocol family 1 Using IPI Shortcut mode BIOS EDD facility v0.16 2004-Jun-25, 2 devices found md: Autodetecting RAID arrays. md: autorun ... md: ... autorun DONE. RAMDISK: Compressed image found at block 0 VFS: Mounted root (ext2 filesystem). SCSI subsystem initialized libata version 1.20 loaded. sata_via 0000:00:0f.0: version 1.1 sata_via 0000:00:0f.0: routed to hard irq line 11 ata1: SATA max UDMA/133 cmd 0xEC00 ctl 0xE802 bmdma 0xDC00 irq 11 ata2: SATA max UDMA/133 cmd 0xE400 ctl 0xE002 bmdma 0xDC08 irq 11 input: GenPS/2 Genius Mouse as /class/input/input1 ata1: SATA link down (SStatus 0) scsi0 : sata_via ata2: SATA link down (SStatus 0) scsi1 : sata_via ReiserFS: hdb2: found reiserfs format "3.6" with standard journal ReiserFS: hdb2: using ordered data mode ReiserFS: hdb2: journal params: device hdb2, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 ReiserFS: hdb2: checking transaction log (hdb2) ReiserFS: hdb2: Using r5 hash to sort names Freeing unused kernel memory: 208k freed usbcore: registered new driver usbfs usbcore: registered new driver hub USB Universal Host Controller Interface driver v2.3 PCI: Via IRQ fixup for 0000:00:10.0, from 11 to 5 uhci_hcd 0000:00:10.0: UHCI Host Controller uhci_hcd 0000:00:10.0: detected 2 ports uhci_hcd 0000:00:10.0: uhci_check_and_reset_hc: cmd = 0x0000 uhci_hcd 0000:00:10.0: Performing full reset drivers/usb/core/inode.c: creating file 'devices' drivers/usb/core/inode.c: creating file '001' uhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 1 uhci_hcd 0000:00:10.0: irq 21, io base 0x0000c400 usb usb1: default language 0x0409 usb usb1: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb1: Product: UHCI Host Controller usb usb1: Manufacturer: Linux 2.6.16-rc5-dirty uhci_hcd usb usb1: SerialNumber: 0000:00:10.0 usb usb1: uevent usb usb1: device is self-powered usb usb1: configuration #1 chosen from 1 choice usb usb1: adding 1-0:1.0 (config #1, interface 0) usb 1-0:1.0: uevent hub 1-0:1.0: usb_probe_interface hub 1-0:1.0: usb_probe_interface - got id hub 1-0:1.0: USB hub found hub 1-0:1.0: 2 ports detected hub 1-0:1.0: standalone hub hub 1-0:1.0: no power switching (usb 1.0) hub 1-0:1.0: individual port over-current protection hub 1-0:1.0: power on to power good time: 2ms hub 1-0:1.0: local power source is good hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000 drivers/usb/core/inode.c: creating file '001' uhci_hcd 0000:00:10.0: port 1 portsc 018a,00 hub 1-0:1.0: port 1, status 0300, change 0003, 1.5 Mb/s PCI: Via IRQ fixup for 0000:00:10.1, from 11 to 5 uhci_hcd 0000:00:10.1: UHCI Host Controller uhci_hcd 0000:00:10.1: detected 2 ports uhci_hcd 0000:00:10.1: uhci_check_and_reset_hc: cmd = 0x0000 uhci_hcd 0000:00:10.1: Performing full reset drivers/usb/core/inode.c: creating file '002' uhci_hcd 0000:00:10.1: new USB bus registered, assigned bus number 2 uhci_hcd 0000:00:10.1: irq 21, io base 0x0000c800 usb usb2: default language 0x0409 usb usb2: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb2: Product: UHCI Host Controller usb usb2: Manufacturer: Linux 2.6.16-rc5-dirty uhci_hcd usb usb2: SerialNumber: 0000:00:10.1 usb usb2: uevent usb usb2: device is self-powered usb usb2: configuration #1 chosen from 1 choice usb usb2: adding 2-0:1.0 (config #1, interface 0) usb 2-0:1.0: uevent hub 2-0:1.0: usb_probe_interface hub 2-0:1.0: usb_probe_interface - got id hub 2-0:1.0: USB hub found hub 2-0:1.0: 2 ports detected hub 2-0:1.0: standalone hub hub 2-0:1.0: no power switching (usb 1.0) hub 2-0:1.0: individual port over-current protection hub 2-0:1.0: power on to power good time: 2ms hub 2-0:1.0: local power source is good hub 1-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x300 uhci_hcd 0000:00:10.0: port 2 portsc 018a,00 hub 1-0:1.0: port 2, status 0300, change 0003, 1.5 Mb/s drivers/usb/core/inode.c: creating file '001' uhci_hcd 0000:00:10.2: UHCI Host Controller uhci_hcd 0000:00:10.2: detected 2 ports uhci_hcd 0000:00:10.2: uhci_check_and_reset_hc: cmd = 0x0000 uhci_hcd 0000:00:10.2: Performing full reset drivers/usb/core/inode.c: creating file '003' uhci_hcd 0000:00:10.2: new USB bus registered, assigned bus number 3 uhci_hcd 0000:00:10.2: irq 21, io base 0x0000cc00 usb usb3: default language 0x0409 usb usb3: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb3: Product: UHCI Host Controller usb usb3: Manufacturer: Linux 2.6.16-rc5-dirty uhci_hcd usb usb3: SerialNumber: 0000:00:10.2 usb usb3: uevent usb usb3: device is self-powered usb usb3: configuration #1 chosen from 1 choice usb usb3: adding 3-0:1.0 (config #1, interface 0) usb 3-0:1.0: uevent hub 3-0:1.0: usb_probe_interface hub 3-0:1.0: usb_probe_interface - got id hub 3-0:1.0: USB hub found hub 3-0:1.0: 2 ports detected hub 3-0:1.0: standalone hub hub 3-0:1.0: no power switching (usb 1.0) hub 3-0:1.0: individual port over-current protection hub 3-0:1.0: power on to power good time: 2ms hub 3-0:1.0: local power source is good hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x300 hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000 hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0006 uhci_hcd 0000:00:10.1: port 1 portsc 018a,00 hub 2-0:1.0: port 1, status 0300, change 0003, 1.5 Mb/s drivers/usb/core/inode.c: creating file '001' uhci_hcd 0000:00:10.3: UHCI Host Controller uhci_hcd 0000:00:10.3: detected 2 ports uhci_hcd 0000:00:10.3: uhci_check_and_reset_hc: cmd = 0x0000 uhci_hcd 0000:00:10.3: Performing full reset drivers/usb/core/inode.c: creating file '004' uhci_hcd 0000:00:10.3: new USB bus registered, assigned bus number 4 uhci_hcd 0000:00:10.3: irq 21, io base 0x0000d000 usb usb4: default language 0x0409 usb usb4: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb4: Product: UHCI Host Controller usb usb4: Manufacturer: Linux 2.6.16-rc5-dirty uhci_hcd usb usb4: SerialNumber: 0000:00:10.3 usb usb4: uevent usb usb4: device is self-powered usb usb4: configuration #1 chosen from 1 choice usb usb4: adding 4-0:1.0 (config #1, interface 0) usb 4-0:1.0: uevent hub 4-0:1.0: usb_probe_interface hub 4-0:1.0: usb_probe_interface - got id hub 4-0:1.0: USB hub found hub 4-0:1.0: 2 ports detected hub 4-0:1.0: standalone hub hub 4-0:1.0: no power switching (usb 1.0) hub 4-0:1.0: individual port over-current protection hub 4-0:1.0: power on to power good time: 2ms hub 4-0:1.0: local power source is good hub 2-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x300 uhci_hcd 0000:00:10.1: port 2 portsc 008a,00 hub 2-0:1.0: port 2, status 0100, change 0003, 12 Mb/s drivers/usb/core/inode.c: creating file '001' hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0006 uhci_hcd 0000:00:10.2: port 1 portsc 018a,00 hub 3-0:1.0: port 1, status 0300, change 0003, 1.5 Mb/s ehci_hcd: block sizes: qh 128 qtd 96 itd 192 sitd 96 PCI: Via IRQ fixup for 0000:00:10.4, from 10 to 5 ehci_hcd 0000:00:10.4: EHCI Host Controller ehci_hcd 0000:00:10.4: reset hcs_params 0x4208 dbg=0 cc=4 pcc=2 ordered !ppc ports=8 ehci_hcd 0000:00:10.4: reset hcc_params 6872 thresh 7 uframes 256/512/1024 ehci_hcd 0000:00:10.4: MWI active drivers/usb/core/inode.c: creating file '005' ehci_hcd 0000:00:10.4: new USB bus registered, assigned bus number 5 ehci_hcd 0000:00:10.4: irq 21, io mem 0xdfff7600 ehci_hcd 0000:00:10.4: reset command 080002 (park)=0 ithresh=8 period=1024 Reset HALT ehci_hcd 0000:00:10.4: init command 010009 (park)=0 ithresh=1 period=256 RUN ehci_hcd 0000:00:10.4: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 usb usb5: default language 0x0409 usb usb5: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb5: Product: EHCI Host Controller usb usb5: Manufacturer: Linux 2.6.16-rc5-dirty ehci_hcd usb usb5: SerialNumber: 0000:00:10.4 usb usb5: uevent usb usb5: device is self-powered usb usb5: configuration #1 chosen from 1 choice usb usb5: adding 5-0:1.0 (config #1, interface 0) usb 5-0:1.0: uevent hub 5-0:1.0: usb_probe_interface hub 5-0:1.0: usb_probe_interface - got id hub 5-0:1.0: USB hub found hub 5-0:1.0: 8 ports detected hub 5-0:1.0: standalone hub hub 5-0:1.0: no power switching (usb 1.0) hub 5-0:1.0: individual port over-current protection hub 5-0:1.0: Single TT hub 5-0:1.0: TT requires at most 8 FS bit times (666 ns) hub 5-0:1.0: power on to power good time: 20ms hub 5-0:1.0: local power source is good hub 3-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x300 uhci_hcd 0000:00:10.2: port 2 portsc 008a,00 hub 3-0:1.0: port 2, status 0100, change 0003, 12 Mb/s drivers/usb/core/inode.c: creating file '001' ts: Compaq touchscreen protocol output hub 3-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 hub 4-0:1.0: state 7 ports 2 chg 0000 evt 0006 uhci_hcd 0000:00:10.3: port 1 portsc 008a,00 hub 4-0:1.0: port 1, status 0100, change 0003, 12 Mb/s hub 4-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x100 uhci_hcd 0000:00:10.3: port 2 portsc 008a,00 hub 4-0:1.0: port 2, status 0100, change 0003, 12 Mb/s hub 4-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000 hub 5-0:1.0: state 7 ports 8 chg 0000 evt 0000 uhci_hcd 0000:00:10.0: suspend_rh (auto-stop) uhci_hcd 0000:00:10.1: suspend_rh (auto-stop) uhci_hcd 0000:00:10.2: suspend_rh (auto-stop) uhci_hcd 0000:00:10.3: suspend_rh (auto-stop) device-mapper: 4.5.0-ioctl (2005-10-04) initialised: dm-devel@redhat.com Adding 265032k swap on /dev/hda6. Priority:-1 extents:1 across:265032k Adding 506008k swap on /dev/hdb6. Priority:-2 extents:1 across:506008k Linux agpgart interface v0.101 (c) Dave Jones agpgart: Detected VIA KT400/KT400A/KT600 chipset agpgart: AGP aperture is 128M @ 0xe0000000 ReiserFS: dm-0: found reiserfs format "3.6" with standard journal ReiserFS: dm-0: using ordered data mode ReiserFS: dm-0: journal params: device dm-0, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 ReiserFS: dm-0: checking transaction log (dm-0) ReiserFS: dm-0: Using r5 hash to sort names NTFS driver 2.1.26 [Flags: R/O MODULE]. NTFS volume version 3.1. loop: loaded (max 8 devices) ieee1394: Initialized config rom entry `ip1394' PCI: Via IRQ fixup for 0000:00:0e.0, from 5 to 1 ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[17] MMIO=[dfff7800-dfff7fff] Max Packet=[2048] IR/IT contexts=[8/8] hdc: ATAPI 48X DVD-ROM DVD-R CD-R/RW drive, 2048kB Cache, UDMA(33) Uniform CD-ROM driver Revision: 3.20 hdd: ATAPI 48X CD-ROM CD-R/RW drive, 2048kB Cache, UDMA(33) ip_conntrack version 2.4 (7167 buckets, 57336 max) - 232 bytes per conntrack ieee1394: Host added: ID:BUS[0-00:1023] GUID[000010dc0037d8ec] eth1394: eth0: IEEE-1394 IPv4 over 1394 Ethernet (fw-host0) FDC 0 is a post-1991 82077 NET: Registered protocol family 17 tg3.c:v3.49 (Feb 2, 2006) eth0: Tigon3 [partno(BCM95705A50) rev 3003 PHY(5705)] (PCI:33MHz:32-bit) 10/100/1000BaseT Ethernet 00:0c:76:41:7c:16 eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[0] Split[0] WireSpeed[0] TSOcap[1] eth0: dma_rwctrl[763f0000] ip_tables: (C) 2000-2006 Netfilter Core Team ip_conntrack version 2.4 (7167 buckets, 57336 max) - 232 bytes per conntrack ipt_recent v0.3.1: Stephen Frost <sfrost@snowman.net>. http://snowman.net/projects/ipt_recent/ ipt_owner: pid, sid and command matching not supported anymore tg3: eth0: Link is up at 100 Mbps, full duplex. tg3: eth0: Flow control is off for TX and off for RX. usbcore: registered new driver usblp drivers/usb/class/usblp.c: v0.13: USB Printer Device Class driver parport: PnPBIOS parport detected. parport0: PC-style at 0x378 (0x778), irq 7, dma 3 [PCSPP,TRISTATE,COMPAT,EPP,ECP,DMA] lp0: using parport0 (interrupt-driven). lp0: console ready PCI: Via IRQ fixup for 0000:00:11.5, from 10 to 6 PCI: Setting latency timer of device 0000:00:11.5 to 64 Bluetooth: Core ver 2.8 NET: Registered protocol family 31 Bluetooth: HCI device and connection manager initialized Bluetooth: HCI socket layer initialized NET: Registered protocol family 10 lo: Disabled Privacy Extensions IPv6 over IPv4 tunneling driver hub 5-0:1.0: state 7 ports 8 chg 0000 evt 0010 ehci_hcd 0000:00:10.4: GetStatus port 4 status 001803 POWER sig=j CSC CONNECT hub 5-0:1.0: port 4, status 0501, change 0001, 480 Mb/s hub 5-0:1.0: debounce: port 4: total 100ms stable 100ms status 0x501 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: new high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: default language 0x0409 usb 5-4: new device strings: Mfr=1, Product=2, SerialNumber=3 usb 5-4: Product: Zen Nano Plus usb 5-4: Manufacturer: CREATIVE usb 5-4: SerialNumber: 0002F685DC219012 usb 5-4: uevent usb 5-4: device is bus-powered usb 5-4: configuration #1 chosen from 1 choice usb 5-4: adding 5-4:1.0 (config #1, interface 0) usb 5-4:1.0: uevent drivers/usb/core/inode.c: creating file '002' Initializing USB Mass Storage driver... usb-storage 5-4:1.0: usb_probe_interface usb-storage 5-4:1.0: usb_probe_interface - got id scsi2 : SCSI emulation for USB Mass Storage devices usb-storage: device found at 2 usb-storage: waiting for device to settle before scanning usbcore: registered new driver usb-storage USB Mass Storage support registered. Vendor: CREATIVE Model: Zen Nano Plus Rev: 1103 Type: Direct-Access ANSI SCSI revision: 04 SCSI device sda: 509248 2048-byte hdwr sectors (1043 MB) sda: Write Protect is off sda: Mode Sense: 38 00 00 00 sda: assuming drive cache: write through SCSI device sda: 509248 2048-byte hdwr sectors (1043 MB) sda: Write Protect is off sda: Mode Sense: 38 00 00 00 sda: assuming drive cache: write through sda: sda1 sd 2:0:0:0: Attached scsi removable disk sda usb-storage: device scan complete <<<< ok till here, the errors follow: >>>> ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 usb 5-4: usb-storage timed out on ep0in len=0/64 usb 5-4: usb-storage timed out on ep0in len=0/64 usb 5-4: usb-storage timed out on ep0in len=0/64 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: device descriptor read/64, error -110 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT sd 2:0:0:0: SCSI error: return code = 0x50000 end_request: I/O error, dev sda, sector 521532 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT usb 5-4: reset high speed USB device using ehci_hcd and address 2 ehci_hcd 0000:00:10.4: port 4 high speed ehci_hcd 0000:00:10.4: GetStatus port 4 status 001005 POWER sig=se0 PE CONNECT <<< somewhere(?) here I've physicaly disconnected the device >>> ehci_hcd 0000:00:10.4: devpath 4 ep0out 3strikes ehci_hcd 0000:00:10.4: GetStatus port 4 status 001002 POWER sig=se0 CSC ehci_hcd 0000:00:10.4: GetStatus port 4 status 001000 POWER sig=se0 ehci_hcd 0000:00:10.4: GetStatus port 4 status 001000 POWER sig=se0 ehci_hcd 0000:00:10.4: GetStatus port 4 status 001000 POWER sig=se0 hub 5-0:1.0: logical disconnect on port 4 sd 2:0:0:0: scsi: Device offlined - not ready after error recovery sd 2:0:0:0: SCSI error: return code = 0x50000 end_request: I/O error, dev sda, sector 521540 sd 2:0:0:0: rejecting I/O to offline device sd 2:0:0:0: rejecting I/O to offline device hub 5-0:1.0: state 7 ports 8 chg 0010 evt 0000 hub 5-0:1.0: port 4, status 0100, change 0000, 12 Mb/s usb 5-4: USB disconnect, address 2 usb 5-4: usb_disable_device nuking all URBs usb 5-4: unregistering interface 5-4:1.0 sd 2:0:0:0: SCSI error: return code = 0x10000 end_request: I/O error, dev sda, sector 78028 Buffer I/O error on device sda1, logical block 19475 lost page write due to I/O error on sda1 usb 5-4:1.0: uevent usb 5-4: unregistering device usb 5-4: uevent lspci -v: ========== 00:00.0 Host bridge: VIA Technologies, Inc. VT8377 [KT400/KT600 AGP] Host Bridge (rev 80) Subsystem: VIA Technologies, Inc.: Unknown device 0000 Flags: bus master, 66Mhz, medium devsel, latency 8 Memory at e0000000 (32-bit, prefetchable) [size=128M] Capabilities: [80] AGP version 3.5 Capabilities: [c0] Power Management version 2 00:01.0 PCI bridge: VIA Technologies, Inc. VT8237 PCI Bridge (prog-if 00 [Normal decode]) Flags: bus master, 66Mhz, medium devsel, latency 0 Bus: primary=00, secondary=01, subordinate=01, sec-latency=0 Memory behind bridge: dde00000-dfefffff Prefetchable memory behind bridge: cdd00000-ddcfffff Capabilities: [80] Power Management version 2 00:0b.0 Ethernet controller: Broadcom Corporation NetXtreme BCM5788 Gigabit Ethernet (rev 03) Subsystem: Micro-Star International Co., Ltd.: Unknown device 590c Flags: bus master, 66Mhz, medium devsel, latency 32, IRQ 18 Memory at dffe0000 (32-bit, non-prefetchable) [size=64K] Capabilities: [48] Power Management version 2 Capabilities: [50] Vital Product Data Capabilities: [58] Message Signalled Interrupts: 64bit+ Queue=0/3 Enable- 00:0e.0 FireWire (IEEE 1394): VIA Technologies, Inc. IEEE 1394 Host Controller (rev 46) (prog-if 10 [OHCI]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 590d Flags: bus master, medium devsel, latency 32, IRQ 17 Memory at dfff7800 (32-bit, non-prefetchable) [size=2K] I/O ports at d400 [size=128] Capabilities: [50] Power Management version 2 00:0f.0 RAID bus controller: VIA Technologies, Inc. VIA VT6420 SATA RAID Controller (rev 80) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32, IRQ 11 I/O ports at ec00 [size=8] I/O ports at e800 [size=4] I/O ports at e400 [size=8] I/O ports at e000 [size=4] I/O ports at dc00 [size=16] I/O ports at d800 [size=256] Capabilities: [c0] Power Management version 2 00:0f.1 IDE interface: VIA Technologies, Inc. VT82C586A/B/VT82C686/A/B/VT823x/A/C PIPC Bus Master IDE (rev 06) (prog-if 8a [Master SecP PriP]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32 I/O ports at fc00 [size=16] Capabilities: [c0] Power Management version 2 00:10.0 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 81) (prog-if 00 [UHCI]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32, IRQ 21 I/O ports at c400 [size=32] Capabilities: [80] Power Management version 2 00:10.1 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 81) (prog-if 00 [UHCI]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32, IRQ 21 I/O ports at c800 [size=32] Capabilities: [80] Power Management version 2 00:10.2 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 81) (prog-if 00 [UHCI]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32, IRQ 21 I/O ports at cc00 [size=32] Capabilities: [80] Power Management version 2 00:10.3 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 81) (prog-if 00 [UHCI]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32, IRQ 21 I/O ports at d000 [size=32] Capabilities: [80] Power Management version 2 00:10.4 USB Controller: VIA Technologies, Inc. USB 2.0 (rev 86) (prog-if 20 [EHCI]) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: bus master, medium devsel, latency 32, IRQ 21 Memory at dfff7600 (32-bit, non-prefetchable) [size=256] Capabilities: [80] Power Management version 2 00:11.0 ISA bridge: VIA Technologies, Inc. VT8237 ISA bridge [KT600/K8T800/K8T890 South] Subsystem: VIA Technologies, Inc.: Unknown device 0000 Flags: bus master, stepping, medium devsel, latency 0 Capabilities: [c0] Power Management version 2 00:11.5 Multimedia audio controller: VIA Technologies, Inc. VT8233/A/8235/8237 AC97 Audio Controller (rev 60) Subsystem: Micro-Star International Co., Ltd.: Unknown device 5901 Flags: medium devsel, IRQ 22 I/O ports at c000 [size=256] Capabilities: [c0] Power Management version 2 01:00.0 VGA compatible controller: nVidia Corporation NV34 [GeForce FX 5200] (rev a1) (prog-if 00 [VGA]) Subsystem: ASUSTeK Computer Inc.: Unknown device 8180 Flags: bus master, 66Mhz, medium devsel, latency 248, IRQ 16 Memory at de000000 (32-bit, non-prefetchable) [size=16M] Memory at d0000000 (32-bit, prefetchable) [size=128M] Expansion ROM at dfee0000 [disabled] [size=128K] Capabilities: [60] Power Management version 2 Capabilities: [44] AGP version 3.0
david, fun ehci error messages...
Here are some comments that might not be relevant. From your log: SCSI device sda: 509248 2048-byte hdwr sectors (1043 MB) .... sd 2:0:0:0: SCSI error: return code = 0x50000 end_request: I/O error, dev sda, sector 521532 First of all, is that size correct? It's rather unusual for a flash disk to claim to have 2048-byte sectors, and it's also unusual (though certainly not impossible) for one to have a gigabyte of storage. Do you know for a fact whether the player actually has 1 GB or only 256 MB? Second, note the sector number where the error occurred. If we assume that the device's sectors really are only 512 bytes, then the error occurred when the system tried to read well beyond the last sector. (I think the sector value in that error message is expressed using 512-byte logical sectors.) Of course, none of this explains why the device works okay when ehci-hcd isn't loaded.
The device is Creative Zen Nano Plus 1GB - this beast: http://creative.com/products/product.asp?category=213&subcategory=214&product=12720 It has really 1GB unless they invented some new kind of compression ;-)
Created attachment 7547 [details] dmesg without ehci (unloaded after boot) - the device works fine
It's as if the drive wedges itself in the middle of some request, and then stops responding to a USB reset sequence. I can't think of anything Linux can do to make it respond again. We've certainly seen firmware errors (in USB peripherals) that only show up at high speed. If we had a handle on what we're doing to trigger that error, maybe we could avoid it ... but we have no such handle.
I have seen similar problems. One thing that may help is to try to attach the disk to the motherboard directly (to USB ports on the motherboard in the back of the computer) without using any USB cable or USB ports on front panel. I solved my problem by that. The weird thing is that some flash-disks work fine in any slot, some not. Maybe it has something to do with bug 5894?
The problem identified in Bug 6722 might be the cause here (is 100MB transfer done after exactly 2 seconds??). 480Mbits/sec (60MB/s) max. USB 2.0 transfer rate would strongly suggest that...
Any update on this problem? Thanks.
Since no activity in this bug for a while closing it. Please reopen if problem confirmed with recent kernel.