Bug 6078 - USB "device not accepting address XX, error -71" problem
USB "device not accepting address XX, error -71" problem
Status: REJECTED INSUFFICIENT_DATA
Product: Drivers
Classification: Unclassified
Component: USB
i386 Linux
: P2 normal
Assigned To: Greg Kroah-Hartman
:
Depends on:
Blocks: USB 5836
  Show dependency treegraph
 
Reported: 2006-02-15 12:15 UTC by Greg Kroah-Hartman
Modified: 2007-10-30 23:42 UTC (History)
12 users (show)

See Also:
Kernel Version: 2.6.16-rc3
Tree: Mainline
Regression: ---


Attachments
Increase the reset recovery delay time (421 bytes, patch)
2006-02-15 14:29 UTC, Alan Stern
Details | Diff
experimental 2.6.17-rc3 SET_ADDRESS patch (1.58 KB, patch)
2006-05-03 15:41 UTC, David Brownell
Details | Diff

Description Greg Kroah-Hartman 2006-02-15 12:15:14 UTC
 
Comment 1 Greg Kroah-Hartman 2006-02-15 13:36:38 UTC
Ok, I've added everyone who has reported this kind of problem with the
usb stack to this bug.  If you don't want to be on it, please feel free
to remove yourself.

The problem is that the error:
  device not accepting address XX, error -71
is happening for some device in your system, on the latest kernel version.

But unfortunatly, it's not easily reproducable for anyone in the Linux
USB developer group.  None of my devices or systems cause this error.

So, any help in trying to debug this would be greatly appreciated.

I know Alan has a suggested patch that might help people out, if he could
attach it and people could try it out, that would be very helpful.

Also, if people use git, could you try to use 'git bisect' to determine
exactly what change caused this to happen?  I think it was working fine for
2.6.13 or maybe 2.6.14, but 2.6.15 and later has the problem reported for it.
Comment 2 Greg Kroah-Hartman 2006-02-15 13:37:35 UTC
This is also reported in Novell's bugzilla at:
  https://bugzilla.novell.com/show_bug.cgi?id=145079
Comment 3 Alan Stern 2006-02-15 14:29:42 UTC
Created attachment 7360 [details]
Increase the reset recovery delay time

Here's the patch Greg mentioned.  It helped one user with an iPod; I'm sure it
won't help everybody.  In that case the problem was in the iPod, but the
general problem appears to lie in the host controller hardware.
Comment 4 Alan Stern 2006-02-15 14:34:54 UTC
A related bug report is #5777.  Len Brown found that the internal hub in his
laptop's docking station wouldn't accept an address until he reloaded ehci-hcd.
 However, he also found that using a different .config fixed it.  Nobody has
tried to duplicate his results or interpolate between the two .configs to see if
the problem can be traced to a single item.
Comment 5 Solomon Peachy 2006-03-09 13:45:41 UTC
I have this problem on a bus-powered High-speed USB drive.  If I plug it into
the onboard OHCI controller, it works.  If I plug it into an add-in ALI
OHCI/EHCI card, I get the -71 error.  I haven't tried unloading the EHCI
component.  

This machine is a Serverworks Dual P3 box and is running the Fedora
2.6.15-1.1833_FC4smp kernel; the USB disk is for backup purposes.

Due to the production nature of the machine I can't take it down for random tests.

'lspci -v' output:

00:02.0 USB Controller: ALi Corporation USB 1.1 Controller (rev 03) (prog-if 10
[OHCI])
        Subsystem: ALi Corporation USB 1.1 Controller
        Flags: bus master, 66Mhz, medium devsel, latency 64, IRQ 201
        Memory at fdaee000 (32-bit, non-prefetchable) [size=4K]
        Capabilities: <available only to root>

00:02.3 USB Controller: ALi Corporation USB 2.0 Controller (rev 01) (prog-if 20
[EHCI])
        Subsystem: Unknown device 2020:8888
        Flags: bus master, 66Mhz, medium devsel, latency 64, IRQ 209
        Memory at fdaefe00 (32-bit, non-prefetchable) [size=256]
        Capabilities: <available only to root>

'lsusb' output:

Bus 002 Device 004: ID 04b4:6830 Cypress Semiconductor Corp. USB-2.0 IDE Adapter
Comment 6 Solomon Peachy 2006-03-31 08:27:23 UTC
As a FYI, Using Fedora's 2.6.16-1.2069_FC4 kernel (based on 2.6.16.1) I'm still
seeing this.  If I remove ehci_hcd, the device comes up just fine, albeit at
full (ohci) speed.  If I unload/reload ehci_hcd, the device still malfunctions:

ACPI: PCI Interrupt 0000:00:02.3[A] -> GSI 18 (level, low) -> IRQ 21
ehci_hcd 0000:00:02.3: EHCI Host Controller
ehci_hcd 0000:00:02.3: debug port 1
ehci_hcd 0000:00:02.3: new USB bus registered, assigned bus number 1
ehci_hcd 0000:00:02.3: irq 21, io mem 0xfdaefe00
ehci_hcd 0000:00:02.3: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 6 ports detected
usb 1-1: new high speed USB device using ehci_hcd and address 2
usb 1-1: device not accepting address 2, error -71
usb 1-1: new high speed USB device using ehci_hcd and address 3
usb 1-1: unable to read config index 0 descriptor/start
usb 1-1: can't read configurations, error -71
usb 1-1: new high speed USB device using ehci_hcd and address 4
usb 1-1: device not accepting address 4, error -71
usb 1-1: new high speed USB device using ehci_hcd and address 5
usb 1-1: string descriptor 0 read error: -71
usb 1-1: string descriptor 0 read error: -71
usb 1-1: string descriptor 0 read error: -71
usb 1-1: configuration #1 chosen from 1 choice
usb 1-1: can't set config #1, error -71

At this point it shows up in 'lsusb' but is otherwise dead.

There are a few other load/plug/etc permutations I can try.
Comment 7 Alan Stern 2006-03-31 08:40:30 UTC
Solomon, your problem may simply be caused by a poor USB connection.  That is,
the cable may work okay at full speed but not at high speed.  Check the USB
cable and connections.  It could also be due to a hardware problem in the disk
drive's USB interface.

Sometimes there are just some small incompatibilities between pieces of
hardware.  I've got a USB disk drive and cable that don't work on my home PC. 
Switching any one of the PC, the cable, or the drive is enough to get things
working again.
Comment 8 David Brownell 2006-05-03 15:41:12 UTC
Created attachment 8021 [details]
experimental 2.6.17-rc3 SET_ADDRESS patch

Worth maybe trying this patch.	When SET_ADDRESS fails, the state of the
device is actually indeterminate.  Linux currently assumes the operation
actually succeeded, which is rather optimistic.  This patch makes a more
pessimistic assumption.
Comment 9 David Brownell 2006-06-13 12:42:22 UTC
PING.  Have you actually tried the patch?  It's been sitting 
there for over a month now waiting for you ...  
 
Comment 10 Greg Oliver 2006-07-08 12:58:45 UTC
I have seen this probolem with my Motorola Phone since 2.6.13 I believe.  I just
compiled 2.6.17-rc3 with debug turned on for USB, and here is th eoutput if it
helps.  udev loaded cdc_acm as expected, and the phone charged for ~4 seconds
and then quit.  Better than 2.6.16 was doing.  This was the only time it has
worked at all - even for 4 seconds since it has happened after the fresh reboot.
 removing the modules and reloading them have no affect either.


greg@greg-laptop ~ $ lspci
00:00.0 Host bridge: Intel Corporation 82845 845 (Brookdale) Chipset Host Bridge
(rev 04)
00:01.0 PCI bridge: Intel Corporation 82845 845 (Brookdale) Chipset AGP Bridge
(rev 04)
00:1d.0 USB Controller: Intel Corporation 82801CA/CAM USB (Hub #1) (rev 02)
00:1d.2 USB Controller: Intel Corporation 82801CA/CAM USB (Hub #3) (rev 02)
00:1e.0 PCI bridge: Intel Corporation 82801 Mobile PCI Bridge (rev 42)
00:1f.0 ISA bridge: Intel Corporation 82801CAM ISA Bridge (LPC) (rev 02)
00:1f.1 IDE interface: Intel Corporation 82801CAM IDE U100 (rev 02)
00:1f.5 Multimedia audio controller: Intel Corporation 82801CA/CAM AC'97 Audio
Controller (rev 02)
00:1f.6 Modem: Intel Corporation 82801CA/CAM AC'97 Modem Controller (rev 02)
01:00.0 VGA compatible controller: nVidia Corporation NV11 [GeForce2 Go] (rev b2)
02:00.0 Ethernet controller: 3Com Corporation 3c905C-TX/TX-M [Tornado] (rev 78)
02:01.0 CardBus bridge: Texas Instruments PCI4451 PC card Cardbus Controller
02:01.1 CardBus bridge: Texas Instruments PCI4451 PC card Cardbus Controller
02:01.2 FireWire (IEEE 1394): Texas Instruments PCI4451 IEEE-1394 Controller

greg@greg-laptop ~ $ lsusb
Bus 002 Device 001: ID 0000:0000
Bus 001 Device 002: ID 1241:1177 Belkin F8E842-DL Mouse
Bus 001 Device 001: ID 0000:0000


--syslog--
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: wakeup_rh (auto-start)
Jul  8 14:50:29 greg-laptop hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0002
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 0082,00
Jul  8 14:50:29 greg-laptop hub 2-0:1.0: port 1, status 0100, change 0001, 12 Mb/s
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 0183,00
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 01a3,00
Jul  8 14:50:29 greg-laptop hub 2-0:1.0: debounce: port 1: total 125ms stable
100ms status 0x301
Jul  8 14:50:29 greg-laptop usb 2-1: new low speed USB device using uhci_hcd and
address 2
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b030)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b030] link (1fc2b060) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=37817520)
Jul  8 14:50:29 greg-laptop 2: [dfc2b060] link (1fc2b090) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b090] link (1fc2b0c0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b0c0] link (1fc2b0f0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b0f0] link (1fc2b120) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b120] link (1fc2b150) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b150] link (1fc2b180) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b180] link (1fc2b1b0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b1b0] link (1fc2b1e0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b1e0] link (1fc2b210) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b210] link (00000000) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b210)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b210] link (1fc2b240) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=37817520)
Jul  8 14:50:29 greg-laptop 2: [dfc2b240] link (1fc2b270) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b270] link (1fc2b2a0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b2a0] link (1fc2b2d0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b2d0] link (1fc2b300) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b300] link (1fc2b330) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b330] link (1fc2b360) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b360] link (1fc2b390) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b390] link (1fc2b3c0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b3c0] link (1fc2b3f0) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b3f0] link (00000000) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b3f0)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b3f0] link (1fc2b030) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=37817520)
Jul  8 14:50:29 greg-laptop 2: [dfc2b030] link (1fc2b060) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b060] link (1fc2b090) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b090] link (1fc2b0c0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b0c0] link (1fc2b0f0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b0f0] link (1fc2b120) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b120] link (1fc2b150) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b150] link (1fc2b180) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b180] link (1fc2b1b0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b1b0] link (1fc2b1e0) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b1e0] link (1fc2b210) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop usb 2-1: device descriptor read/64, error -71
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b1e0)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b1e0] link (1fc2b030) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=3551cac0)
Jul  8 14:50:29 greg-laptop 2: [dfc2b030] link (1fc2b060) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b060] link (1fc2b090) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b090] link (1fc2b0c0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b0c0] link (1fc2b0f0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b0f0] link (1fc2b120) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b120] link (1fc2b150) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b150] link (1fc2b180) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b180] link (1fc2b1b0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b1b0] link (1fc2b210) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b210] link (1fc2b240) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b210)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b210] link (1fc2b240) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=3551cac0)
Jul  8 14:50:29 greg-laptop 2: [dfc2b240] link (1fc2b270) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b270] link (1fc2b2a0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b2a0] link (1fc2b2d0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b2d0] link (1fc2b300) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b300] link (1fc2b330) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b330] link (1fc2b360) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b360] link (1fc2b390) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b390] link (1fc2b3c0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b3c0] link (1fc2b3f0) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b3f0] link (1fc2b030) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b3f0)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b3f0] link (1fc2b030) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=3551cac0)
Jul  8 14:50:29 greg-laptop 2: [dfc2b030] link (1fc2b060) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b060] link (1fc2b090) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b090] link (1fc2b0c0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b0c0] link (1fc2b0f0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b0f0] link (1fc2b120) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b120] link (1fc2b150) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b150] link (1fc2b180) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b180] link (1fc2b1b0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b1b0] link (1fc2b1e0) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b1e0] link (1fc2b030) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop usb 2-1: device descriptor read/64, error -71
Jul  8 14:50:29 greg-laptop usb 2-1: new low speed USB device using uhci_hcd and
address 3
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b030)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b030] link (1fc2b060) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=3551cac0)
Jul  8 14:50:29 greg-laptop 2: [dfc2b060] link (1fc2b090) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b090] link (1fc2b0c0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b0c0] link (1fc2b0f0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b0f0] link (1fc2b120) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b120] link (1fc2b150) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b150] link (1fc2b180) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b180] link (1fc2b1b0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b1b0] link (1fc2b1e0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b1e0] link (1fc2b210) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b210] link (1fc2b240) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b210)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b210] link (1fc2b240) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=3551cac0)
Jul  8 14:50:29 greg-laptop 2: [dfc2b240] link (1fc2b270) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b270] link (1fc2b2a0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b2a0] link (1fc2b2d0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b2d0] link (1fc2b300) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b300] link (1fc2b330) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b330] link (1fc2b360) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b360] link (1fc2b390) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b390] link (1fc2b3c0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b3c0] link (1fc2b3f0) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b3f0] link (1fc2b030) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:29 greg-laptop uhci_hcd 0000:00:1d.2: uhci_result_control: failed
with status 440000
Jul  8 14:50:29 greg-laptop [dfc2c380] link (1fc2c2c2) element (1fc2b3f0)
Jul  8 14:50:29 greg-laptop urb_priv [f795d8a8] urb [f7ec93c0] qh [dfc2c380]
Dev=0 EP=0(IN) CTL
Jul  8 14:50:29 greg-laptop 1: [dfc2b3f0] link (1fc2b030) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=0, PID=2d(SETUP) (buf=3551cac0)
Jul  8 14:50:29 greg-laptop 2: [dfc2b030] link (1fc2b060) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac0)
Jul  8 14:50:29 greg-laptop 3: [dfc2b060] link (1fc2b090) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eac8)
Jul  8 14:50:29 greg-laptop 4: [dfc2b090] link (1fc2b0c0) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead0)
Jul  8 14:50:29 greg-laptop 5: [dfc2b0c0] link (1fc2b0f0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7ead8)
Jul  8 14:50:29 greg-laptop 6: [dfc2b0f0] link (1fc2b120) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae0)
Jul  8 14:50:29 greg-laptop 7: [dfc2b120] link (1fc2b150) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eae8)
Jul  8 14:50:29 greg-laptop 8: [dfc2b150] link (1fc2b180) e3 SPD LS Active
Length=0 MaxLen=7 DT1 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf0)
Jul  8 14:50:29 greg-laptop 9: [dfc2b180] link (1fc2b1b0) e3 SPD LS Active
Length=0 MaxLen=7 DT0 EndPt=0 Dev=0, PID=69(IN) (buf=33d7eaf8)
Jul  8 14:50:29 greg-laptop 10: [dfc2b1b0] link (1fc2b1e0) e3 LS IOC Active
Length=0 MaxLen=7ff DT1 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop Dummy TD
Jul  8 14:50:29 greg-laptop [dfc2b1e0] link (1fc2b210) e0 Length=0 MaxLen=7ff
DT0 EndPt=0 Dev=0, PID=e1(OUT) (buf=00000000)
Jul  8 14:50:29 greg-laptop
Jul  8 14:50:30 greg-laptop hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0002
Jul  8 14:50:30 greg-laptop hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0002
Jul  8 14:50:30 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 0093,00
Jul  8 14:50:30 greg-laptop hub 2-0:1.0: port 1, status 0101, change 0001, 12 Mb/s
Jul  8 14:50:30 greg-laptop hub 2-0:1.0: debounce: port 1: total 100ms stable
100ms status 0x101
Jul  8 14:50:30 greg-laptop usb 2-1: new full speed USB device using uhci_hcd
and address 4
Jul  8 14:50:30 greg-laptop usb 2-1: ep0 maxpacket = 8
Jul  8 14:50:30 greg-laptop usb 2-1: skipped 4 descriptors after interface
Jul  8 14:50:30 greg-laptop usb 2-1: skipped 4 descriptors after interface
Jul  8 14:50:30 greg-laptop usb 2-1: default language 0x0409
Jul  8 14:50:30 greg-laptop usb 2-1: new device strings: Mfr=1, Product=2,
SerialNumber=0
Jul  8 14:50:30 greg-laptop usb 2-1: Product: Motorola Phone (V3)
Jul  8 14:50:30 greg-laptop usb 2-1: Manufacturer: Motorola Inc.
Jul  8 14:50:30 greg-laptop usb 2-1: uevent
Jul  8 14:50:30 greg-laptop usb 2-1: configuration #1 chosen from 2 choices
Jul  8 14:50:30 greg-laptop usb 2-1: adding 2-1:1.0 (config #1, interface 0)
Jul  8 14:50:30 greg-laptop usb 2-1:1.0: uevent
Jul  8 14:50:30 greg-laptop usb 2-1: adding 2-1:1.1 (config #1, interface 1)
Jul  8 14:50:30 greg-laptop usb 2-1:1.1: uevent
Jul  8 14:50:30 greg-laptop drivers/usb/core/inode.c: creating file '004'
Jul  8 14:50:30 greg-laptop hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0002
Jul  8 14:50:30 greg-laptop usb.agent[10281]: Keeping default configuration with
/sys//devices/pci0000:00/0000:00:1d.2/usb2/2-1
Jul  8 14:50:32 greg-laptop cdc_acm 2-1:1.0: usb_probe_interface
Jul  8 14:50:32 greg-laptop cdc_acm 2-1:1.0: usb_probe_interface - got id
Jul  8 14:50:32 greg-laptop cdc_acm 2-1:1.0: ttyACM0: USB ACM device
Jul  8 14:50:32 greg-laptop usbcore: registered new driver cdc_acm
Jul  8 14:50:32 greg-laptop drivers/usb/class/cdc-acm.c: v0.25:USB Abstract
Control Model driver for USB modems and ISDN adapters
Jul  8 14:50:36 greg-laptop hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0002
Jul  8 14:50:36 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 00b9,00
Jul  8 14:50:36 greg-laptop hub 2-0:1.0: port 1 enable change, status 00000101
Jul  8 14:50:36 greg-laptop hub 2-0:1.0: port 1 disabled by hub (EMI?),
re-enabling...
Jul  8 14:50:36 greg-laptop hub 2-0:1.0: port 1, status 0101, change 0002, 12 Mb/s
Jul  8 14:50:36 greg-laptop usb 2-1: USB disconnect, address 4
Jul  8 14:50:36 greg-laptop usb 2-1: usb_disable_device nuking all URBs
Jul  8 14:50:36 greg-laptop usb 2-1: unregistering interface 2-1:1.0
Jul  8 14:50:36 greg-laptop usb 2-1:1.0: uevent
Jul  8 14:50:36 greg-laptop usb 2-1: unregistering interface 2-1:1.1
Jul  8 14:50:36 greg-laptop usb 2-1:1.1: uevent
Jul  8 14:50:36 greg-laptop usb 2-1: unregistering device
Jul  8 14:50:36 greg-laptop usb 2-1: uevent
Jul  8 14:50:37 greg-laptop uhci_hcd 0000:00:1d.2: suspend_rh (auto-stop)
Jul  8 14:51:06 greg-laptop uhci_hcd 0000:00:1d.2: wakeup_rh (auto-start)
Jul  8 14:51:06 greg-laptop hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0002
Jul  8 14:51:06 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 01a3,00
Jul  8 14:51:06 greg-laptop hub 2-0:1.0: port 1, status 0301, change 0001, 1.5 Mb/s
Jul  8 14:51:06 greg-laptop uhci_hcd 0000:00:1d.2: port 1 portsc 0082,00
Jul  8 14:51:06 greg-laptop hub 2-0:1.0: debounce: port 1: total 125ms stable
100ms status 0x100
Jul  8 14:51:07 greg-laptop uhci_hcd 0000:00:1d.2: suspend_rh (auto-stop)
Comment 11 Greg Kroah-Hartman 2006-08-30 00:47:09 UTC
Am closing due to lack of response.  If this still happens, with the proposed
patch on the latest kernel version, please reopen the bug with and post
the error logs.
Comment 12 Matt Mackall 2007-07-26 09:02:58 UTC
I'm seeing this with 2.6.22.1 while trying to talk to a gumstix.

[93972.822392] usb 3-2: new full speed USB device using uhci_hcd and address 3
[93972.946234] usb 3-2: device descriptor read/64, error -71
[93973.172169] usb 3-2: device descriptor read/64, error -71
[93973.389696] usb 3-2: new full speed USB device using uhci_hcd and address 4
[93973.511733] usb 3-2: device descriptor read/64, error -71
[93973.735449] usb 3-2: device descriptor read/64, error -71
[93973.951180] usb 3-2: new full speed USB device using uhci_hcd and address 5
[93974.360529] usb 3-2: device not accepting address 5, error -71
[93974.470526] usb 3-2: new full speed USB device using uhci_hcd and address 6
[93974.877998] usb 3-2: device not accepting address 6, error -71
[93979.977061] usb 3-2: new full speed USB device using uhci_hcd and address 7
[93980.099643] usb 3-2: device descriptor read/64, error -71
[93980.327365] usb 3-2: device descriptor read/64, error -71
[93980.540353] usb 3-2: new full speed USB device using uhci_hcd and address 8
[93980.660196] usb 3-2: device descriptor read/64, error -71
[93980.887913] usb 3-2: device descriptor read/64, error -71
[93981.106438] usb 3-2: new full speed USB device using uhci_hcd and address 9
[93981.513937] usb 3-2: device not accepting address 9, error -71
[93981.622985] usb 3-2: new full speed USB device using uhci_hcd and address 10
[93982.033305] usb 3-2: device not accepting address 10, error -71

Same behavior with two different machines.
Comment 13 Alan Stern 2007-07-26 09:35:13 UTC
Sounds like it could be a wiring problem on the gumstix, or something of that sort.
Comment 14 Phil Lello 2007-10-15 08:16:20 UTC
I'm seeing this problem with my Scanjet 5300C on Ubuntu 7.04 with 2.6.20-16.

I'll try the patch from David Brownell, and let people know if this is works.

This may take a while, as I've never built a kernel under Ubuntu before :)
Comment 15 Phil Lello 2007-10-16 05:06:29 UTC
Nope, the David's patch doesn't fix my issue.

There's nothing new in the logs that I can find, but if i boot in Ubuntu's 'recovery mode', I get extra "device not accepting address X, error -71" messages echo'd to console.

lsusb doesn't show the scanner, but is frequently slow... I guess this is because it has to wait for the bus reset to finish.

e.g. :
phil@Ubuntu:~/kernel$ /usr/bin/time --format="%E" lsusb
Bus 002 Device 001: ID 0000:0000  
Bus 001 Device 002: ID 046d:08f6 Logitech, Inc. 
Bus 001 Device 001: ID 0000:0000  
0:10.51
phil@Ubuntu:~/kernel$ /usr/bin/time --format="%E" lsusb
Bus 002 Device 001: ID 0000:0000  
Bus 001 Device 002: ID 046d:08f6 Logitech, Inc. 
Bus 001 Device 001: ID 0000:0000  
0:10.53
phil@Ubuntu:~/kernel$ /usr/bin/time --format="%E" lsusb
Bus 002 Device 001: ID 0000:0000  
Bus 001 Device 011: ID 03f0:0701 Hewlett-Packard ScanJet 5300c/5370c
Bus 001 Device 002: ID 046d:08f6 Logitech, Inc. 
Bus 001 Device 001: ID 0000:0000  
0:00.11
phil@Ubuntu:~/kernel$ /usr/bin/time --format="%E" lsusb
Bus 002 Device 001: ID 0000:0000  
Bus 001 Device 002: ID 046d:08f6 Logitech, Inc. 
Bus 001 Device 001: ID 0000:0000  
0:10.54

I've not done any kernel debugging before, so please provide hints on anything else useful I can do.
Comment 16 Phil Lello 2007-10-17 06:16:00 UTC
Hmm... just read my own last update and spotted that the scanner actually got picked up once, then disappeared.

I've downloaded some USB docs, and will go through this... as a pure, ill-educated guess, it could be that the SET_ADDRESS is being timed out by the stack, then takes effect on the device, and then getting clobbered by the hub reset.
Comment 17 Phil Lello 2007-10-18 17:23:36 UTC
The SET_ADDRESS problem is fixed in the 2.6.22 kernel.

I can get a preview scan in sane fine, but for some reason it a full scan fails.

This may well be a problem in either sane or libusb, and even if its a usb-kernel bug, it is unlikely to be related to the SET_ADDRESS problem.
Comment 18 spinality 2007-10-30 12:51:45 UTC
Also see http://qa.mandriva.com/show_bug.cgi?id=26728#c41, which includes apparently related information (talking specifically about HP5300C/HP5370C scanners with apparently broken USB protocol) and which includes a patch. 

Note You need to log in before you can comment on or make changes to this bug.