USB fails after suspend to RAM on Dapper

[jmspeex]

Binary package hint: powermgmt-base

After a suspend to RAM, my USB mouse stops working. A dmesg gives me:
[4623238.090000] usb 5-2: new high speed USB device using ehci_hcd and address 2
[4623239.090000] ehci_hcd 0000:00:1d.7: Unlink after no-IRQ? Controller is probably using the wrong IRQ.

The full messages are:
[4623168.689000] ACPI: PCI interrupt for device 0000:02:00.0 disabled
[4623172.638000] Stopping tasks: ==================================================================================================================================================================================|
[4623172.657000] ata2: suspend device
[4623172.660000] ata1: suspend device
[4623173.139000] ACPI: PCI interrupt for device 0000:03:01.0 disabled
[4623173.139000] ata_piix 0000:00:1f.2: suspend PCI device
[4623173.139000] ACPI: PCI interrupt for device 0000:00:1f.2 disabled
[4623173.150000] ACPI: PCI interrupt for device 0000:00:1e.2 disabled
[4623173.150000] ACPI: PCI interrupt for device 0000:00:1d.7 disabled
[4623173.161000] ACPI: PCI interrupt for device 0000:00:1d.3 disabled
[4623173.161000] ACPI: PCI interrupt for device 0000:00:1d.2 disabled
[4623173.161000] ACPI: PCI interrupt for device 0000:00:1d.1 disabled
[4623173.161000] ACPI: PCI interrupt for device 0000:00:1d.0 disabled
[4623173.161000] Back to C!
[4623190.161000] ACPI: PCI Interrupt 0000:00:01.0[A] -> GSI 16 (level, low) -> IRQ 169
[4623190.161000] PCI: Setting latency timer of device 0000:00:01.0 to 64
[4623190.161000] ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 16 (level, low) -> IRQ 169
[4623190.161000] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[4623190.161000] ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 16 (level, low) -> IRQ 169
[4623190.161000] PCI: Setting latency timer of device 0000:00:1d.0 to 64
[4623190.161000] ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 17 (level, low) -> IRQ 209
[4623190.161000] PCI: Setting latency timer of device 0000:00:1d.1 to 64
[4623190.161000] ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 217
[4623190.161000] PCI: Setting latency timer of device 0000:00:1d.2 to 64
[4623190.161000] ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 19 (level, low) -> IRQ 177
[4623190.161000] PCI: Setting latency timer of device 0000:00:1d.3 to 64
[4623190.172000] ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 16 (level, low) -> IRQ 169
[4623190.172000] PCI: Setting latency timer of device 0000:00:1d.7 to 64
[4623190.175000] ehci_hcd 0000:00:1d.7: debug port 1
[4623190.175000] PCI: cache line size of 32 is not supported by device 0000:00:1d.7
[4623190.179000] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[4623190.179000] PCI: Setting latency timer of device 0000:00:1e.0 to 64
[4623190.179000] ACPI: PCI Interrupt 0000:00:1e.2[A] -> GSI 16 (level, low) -> IRQ 169
[4623190.179000] PCI: Setting latency timer of device 0000:00:1e.2 to 64
[4623190.433000] ata_piix 0000:00:1f.2: resume PCI device
[4623190.444000] ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 17 (level, low) -> IRQ 209
[4623190.444000] PCI: Setting latency timer of device 0000:00:1f.2 to 64
[4623190.444000] ACPI: PCI Interrupt 0000:01:00.0[A] -> GSI 16 (level, low) -> IRQ 169
[4623190.444000] ACPI: PCI Interrupt 0000:03:01.0[A] -> GSI 19 (level, low) -> IRQ 177
[4623190.481000] ata1: resume device
[4623190.632000] pata_get_dev_handle: ENTER: dev->bus_id='0000:00:1f.2'
[4623190.632000] pata_get_dev_handle: dev_handle: 0xdffe7820, parent_handle: 0xdffea8e0
[4623190.632000] pata_get_dev_handle: for dev=0x1f.2, addr=0x1f0002, parent=0xdff7b800, *handle=0xdffe7820
[4623190.632000] do_drive_get_GTF: drive w/ adr=0: v: 0x00000000
[4623190.632000] ata1: dev 0 configured for UDMA/100
[4623190.634000] ata2: resume device
[4623190.785000] pata_get_dev_handle: ENTER: dev->bus_id='0000:00:1f.2'
[4623190.785000] pata_get_dev_handle: dev_handle: 0xdffe7820, parent_handle: 0xdffea8e0
[4623190.785000] pata_get_dev_handle: for dev=0x1f.2, addr=0x1f0002, parent=0xdff7b800, *handle=0xdffe7820
[4623190.785000] ata2: dev 0 configured for UDMA/33
[4623190.924000] Restarting tasks... done
[4623191.992000] input: PS/2 Mouse as /class/input/input5
[4623192.019000] input: AlpsPS/2 ALPS GlidePoint as /class/input/input6
[4623195.268000] tg3.c:v3.47 (Dec 28, 2005)
[4623195.268000] ACPI: PCI Interrupt 0000:02:00.0[A] -> GSI 16 (level, low) -> IRQ 169
[4623195.268000] PCI: Setting latency timer of device 0000:02:00.0 to 64
[4623195.274000] eth0: Tigon3 [partno(BCM95751) rev 4001 PHY(5750)] (PCI Express) 10/100/1000BaseT Ethernet 00:12:3f:e9:99:00
[4623195.274000] eth0: RXcsums[1] LinkChgREG[1] MIirq[1] ASF[0] Split[0] WireSpeed[1] TSOcap[1]
[4623195.274000] eth0: dma_rwctrl[76180000]
[4623195.445000] ADDRCONF(NETDEV_UP): eth0: link is not ready
[4623196.277000] ACPI: Lid Switch [LID]
[4623196.277000] ACPI: Power Button (CM) [PBTN]
[4623196.277000] ACPI: Sleep Button (CM) [SBTN]
[4623196.322000] ACPI: Thermal Zone [THM] (47 C)
[4623196.386000] ACPI: AC Adapter [AC] (on-line)
[4623196.441000] [drm] Loading R300 Microcode
[4623196.673000] ACPI: Battery Slot [BAT0] (battery present)
[4623196.673000] ACPI: Battery Slot [BAT1] (battery absent)
[4623197.443000] tg3: eth0: Link is up at 100 Mbps, full duplex.
[4623197.443000] tg3: eth0: Flow control is off for TX and off for RX.
[4623197.445000] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[4623207.867000] eth0: no IPv6 routers present
[4623219.107000] uhci_hcd 0000:00:1d.3: remove, state 1
[4623219.107000] usb usb4: USB disconnect, address 1
[4623219.109000] uhci_hcd 0000:00:1d.3: USB bus 4 deregistered
[4623219.109000] ACPI: PCI interrupt for device 0000:00:1d.3 disabled
[4623219.109000] uhci_hcd 0000:00:1d.2: remove, state 1
[4623219.109000] usb usb3: USB disconnect, address 1
[4623219.110000] uhci_hcd 0000:00:1d.2: USB bus 3 deregistered
[4623219.110000] ACPI: PCI interrupt for device 0000:00:1d.2 disabled
[4623219.110000] uhci_hcd 0000:00:1d.1: remove, state 1
[4623219.110000] usb usb2: USB disconnect, address 1
[4623219.111000] uhci_hcd 0000:00:1d.1: USB bus 2 deregistered
[4623219.112000] ACPI: PCI interrupt for device 0000:00:1d.1 disabled
[4623219.112000] uhci_hcd 0000:00:1d.0: remove, state 1
[4623219.112000] usb usb1: USB disconnect, address 1
[4623219.113000] uhci_hcd 0000:00:1d.0: USB bus 1 deregistered
[4623219.113000] ACPI: PCI interrupt for device 0000:00:1d.0 disabled
[4623222.920000] USB Universal Host Controller Interface driver v2.3
[4623222.920000] ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 16 (level, low) -> IRQ 169
[4623222.921000] PCI: Setting latency timer of device 0000:00:1d.0 to 64
[4623222.921000] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[4623222.921000] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1
[4623222.921000] uhci_hcd 0000:00:1d.0: irq 169, io base 0x0000bf80
[4623222.922000] hub 1-0:1.0: USB hub found
[4623222.922000] hub 1-0:1.0: 2 ports detected
[4623223.023000] ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 17 (level, low) -> IRQ 209
[4623223.023000] PCI: Setting latency timer of device 0000:00:1d.1 to 64
[4623223.023000] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[4623223.025000] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
[4623223.025000] uhci_hcd 0000:00:1d.1: irq 209, io base 0x0000bf60
[4623223.026000] hub 2-0:1.0: USB hub found
[4623223.026000] hub 2-0:1.0: 2 ports detected
[4623223.167000] ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 217
[4623223.167000] PCI: Setting latency timer of device 0000:00:1d.2 to 64
[4623223.167000] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[4623223.168000] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 3
[4623223.168000] uhci_hcd 0000:00:1d.2: irq 217, io base 0x0000bf40
[4623223.169000] hub 3-0:1.0: USB hub found
[4623223.169000] hub 3-0:1.0: 2 ports detected
[4623223.284000] ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 19 (level, low) -> IRQ 177
[4623223.284000] PCI: Setting latency timer of device 0000:00:1d.3 to 64
[4623223.284000] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[4623223.287000] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 4
[4623223.287000] uhci_hcd 0000:00:1d.3: irq 177, io base 0x0000bf20
[4623223.288000] hub 4-0:1.0: USB hub found
[4623223.288000] hub 4-0:1.0: 2 ports detected
[4623234.268000] ehci_hcd 0000:00:1d.7: remove, state 1
[4623234.268000] usb usb5: USB disconnect, address 1
[4623234.268000] usb 5-2: USB disconnect, address 2
[4623234.268000] usb 5-2.2: USB disconnect, address 3
[4623234.268000] usb 5-2.2.4: USB disconnect, address 4
[4623234.276000] ehci_hcd 0000:00:1d.7: USB bus 5 deregistered
[4623234.276000] ACPI: PCI interrupt for device 0000:00:1d.7 disabled
[4623234.482000] usb 1-2: new full speed USB device using uhci_hcd and address 2[4623234.605000] hub 1-2:1.0: USB hub found
[4623234.607000] hub 1-2:1.0: 4 ports detected
[4623234.885000] usb 1-2.2: new full speed USB device using uhci_hcd and address 3
[4623234.970000] hub 1-2.2:1.0: USB hub found
[4623234.972000] hub 1-2.2:1.0: 4 ports detected
[4623235.255000] usb 1-2.2.4: new low speed USB device using uhci_hcd and address 4
[4623235.379000] input: HID 413c:3010 as /class/input/input7
[4623235.379000] input: USB HID v1.10 Mouse [HID 413c:3010] on usb-0000:00:1d.0-2.2.4
[4623237.866000] ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 16 (level, low) -> IRQ 169
[4623237.866000] PCI: Setting latency timer of device 0000:00:1d.7 to 64
[4623237.866000] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[4623237.882000] ehci_hcd 0000:00:1d.7: debug port 1
[4623237.882000] PCI: cache line size of 32 is not supported by device 0000:00:1d.7
[4623237.882000] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 5
[4623237.882000] ehci_hcd 0000:00:1d.7: irq 169, io mem 0xffa80800
[4623237.886000] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[4623237.887000] hub 5-0:1.0: USB hub found
[4623237.887000] hub 5-0:1.0: 8 ports detected
[4623238.090000] usb 5-2: new high speed USB device using ehci_hcd and address 2[4623239.090000] ehci_hcd 0000:00:1d.7: Unlink after no-IRQ? Controller is probably using the wrong IRQ.

[jmspeex (jean-marc-valin)]

Sorry, should mention my setup:
Dell D810 laptop
Pentium-M 2.13 GHz w/ 1 GB RAM
Fresh Dapper install
Default kernel 2.6.15-23-386, *not* tainted
Never seen that problem with Breezy

[Daniel T Chen (crimsun)]

Please ensure that you're using the latest bios for your hardware.

[jmspeex (jean-marc-valin)]

I doubt it's a BIOS issue. Everything always worked fine with Breezy/2.6.12 and I don't want to risk more problem just to use another BIOS. I'm using version A03 of the BIOS and the latest version is A05. The changes from A03 to A04 are:

Feature Enhancements:
1)Support for IDE 48-bit LBA.
2)Support BIOS ROM module.
3)Support Battery Health Meter.
4)HDD acoustic mode support.

Changes from A04 to A05 are:

Feature Enhancement:
1)Update PSA to version 3021.
2)Change the copyright year from 2005 to 2006.
3)Change the Intel new branding logo.
Issue Fixed:
1)Fix issue in 48bit LBA support where USB HDD reports same size as internal HDD.
2)Fix spelling error(Form "concider" to "consider") in the battery health meter page in Setup.
3)Fix issue where Admin password would not allow change of HDD password.

Nothing that looks like the problem here.

[jmspeex (jean-marc-valin)]

OK, since it seemed like this bug was going to be ignored until I upgraded the BIOS, I just upgraded to A05 (latest). Didn't change anything. I also noticed that the bug only happens when I suspend when my laptop is docked.

[jmspeex (jean-marc-valin)]

Why is this still marked as "Needs Info". What other info do you need?

[Peter Whittaker (pwwnow)]

Jean-Marc, sorry no one followed up one this, this report fell through the cracks. If you are still having this problem, would it be possible for you to attach to the report the output of the following commands?

uname -a

sudo lspci -vv

sudo lspci -vvn

sudo dmidecode

This is information required for all ACPI -related problems. Again, I apologize that no one requested this sooner.

Thanks for helping out!

[jmspeex (jean-marc-valin)]

% uname -a
Linux theorix 2.6.15-27-386 #1 PREEMPT Fri Dec 8 17:51:56 UTC 2006 i686 GNU/Linux

% lspci -vv
http://people.xiph.org/~jm/d800_lspci_vv.txt

% lspci -vvn
http://people.xiph.org/~jm/d800_lspci_vvn.txt

% dmidecode
http://people.xiph.org/~jm/d800_dmidecode.txt

[Peter Whittaker (pwwnow)]

Marked "confirmed" based on availability of required logs.

[Launchpad Janitor (janitor)]

Beginning with the Hardy Heron 8.04 development cycle, all open Ubuntu kernel bugs need to be reported against the "linux" kernel package. We are automatically migrating this linux-source-2.6.15 kernel bug to the new "linux" package. We appreciate your patience and understanding as we make this transition. Also, if you would be interested in testing the upcoming Intrepid Ibex 8.10 release, it is available at http://www.ubuntu.com/testing . Please let us know your results. Thanks!

[Leann Ogasawara (leannogasawara)]

The Ubuntu Kernel Team is planning to move to the 2.6.27 kernel for the upcoming Intrepid Ibex 8.10 release. As a result, the kernel team would appreciate it if you could please test this newer 2.6.27 Ubuntu kernel. There are one of two ways you should be able to test:

1) If you are comfortable installing packages on your own, the linux-image-2.6.27-* package is currently available for you to install and test.

--or--

2) The upcoming Alpha5 for Intrepid Ibex 8.10 will contain this newer 2.6.27 Ubuntu kernel. Alpha5 is set to be released Thursday Sept 4. Please watch http://www.ubuntu.com/testing for Alpha5 to be announced. You should then be able to test via a LiveCD.

Please let us know immediately if this newer 2.6.27 kernel resolves the bug reported here or if the issue remains. More importantly, please open a new bug report for each new bug/regression introduced by the 2.6.27 kernel and tag the bug report with 'linux-2.6.27'. Also, please specifically note if the issue does or does not appear in the 2.6.26 kernel. Thanks again, we really appreicate your help and feedback.

[jmspeex (jean-marc-valin)]

This has to be a joke. Nobody has ever done anything about that bug in two years and now I should do more testing so it continues to be ignored? Just close this as WONT_BOTHER like the rest of the bugs.

[Leann Ogasawara (leannogasawara)]

Hi jmspeex,

I apologize that this report has been neglected. It is a constant struggle to keep up with the growing volume of bug reports and the limited number of resources we have available to debug and implement fixes. Per your last comment I'll go ahead and close this report. However, if you do by chance have a change of heart and happen to test we would still appreciate any feedback you may have. Thanks.

[jmspeex (jean-marc-valin)]

How about adding a A_DEVELOPER_IS_INTERESTED_IN_THIS_BUG flag to Launchpad? That way, you could report a bug and only put effort in finding the bug if a developer is actually interested in fixing it. This would greatly reduce wasted effort and perhaps improve the odds of fixing bugs that developers are actually interesting in fixing.

[Jarno Suni (jarnos)]

For what it is worth, at least PS/2 mice can be "restarted" to make them work after resume (if they don't otherwise):
http://en.opensuse.org/Pm-utils#Restarting_the_mouse
Maybe there is some equivalent for USB mice.

[Aaron Clark (aaronwclark)]

I just installed Jaunty (9.04) on my Thinkpad A31 and now usb works again after resuming from suspend.

Unfortunately I have to unplug my US Robotics 5410 WiFi card or it won't come out of suspend and the sound system has to be restarted after resuming to restore sound.

At least these two new problems can be easily worked around - the usb bug was a real pain - and now it's gone!