Hi, On Tue, Dec 05, 2006 at 04:39:34PM -0500, Alan Stern wrote: > > On Tue, Dec 05, 2006 at 07:19:01AM -0500, Dominik Brodowski wrote: > > > Hi, > > > > > > git bisect proved that the patch > > > > > > commit 40f122f343797d02390c5a157372cac0c5b50bb7 > > > Author: Alan Stern <[EMAIL PROTECTED]> > > > Date: Thu Nov 9 14:44:33 2006 -0500 > > > > > > USB: Add autosuspend support to the hub driver > > > > > > This patch (as742b) adds autosuspend/autoresume support to the USB hub > > > driver. The largest aspect of the change is that we no longer need a > > > special flag for root hubs that want to be resumed. Now every hub is > > > autoresumed whenever khubd needs to access it. > > > > > > is the cause for IRQ #10 being disabled on my notebook: > > > > > > Now I tested this a bit further... and strangely, if I modprobe the USB > > modules somewhen later, it is no problem at all. Running many many possible > > combinations of modprobe'ing yenta_socket, ehci_hcd, uhci_hcd and other > > modules loaded at the same time in the init scripts I use, or even using > > /etc/init.d/modules, does not reproduce the error... Very strange. > > I don't entirely trust git-bisect. Can you try reverting just this one > patch by hand, to verify that the problem really does go away?
Verified by hand, well, by "git reset HEAD^ && git checkout -f", and yes, it's caused by autosuspend... BTW, why don't you entirely trust git-bisect? > Also, can you post a system log showing the problem with CONFIG_USB_DEBUG > turned on? It's attached. > If you prevent ehci-hcd.ko from being loaded in the usual way (say by > renaming it), does the problem still occur? No, it doesn't occur. > What about uhci-hcd.ko? If I rename ehci-hcd, uhci-hcd seems to be bound to that hub, and all works well there. Also, ehci-hcd works fine a) if my Matrox USB HD isn't connected to that port [haven't tested other USB devices yet] or b) if the modules uhci-hcd, ehci-hcd and yenta_socket[*] are modprobed in any order after bootup. I can only reproduce it at the stage where udev events are created through uevent at boot time -- it's right then when udev is processing events that this error occurs. Any ideas? Dominik [ 0.000000] Linux version 2.6.19 ([EMAIL PROTECTED]) (gcc-Version 4.1.1 (Gentoo 4.1.1-r1)) #16 PREEMPT Wed Dec 6 21:25:29 EST 2006 ... [ 10.282625] ACPI: bus type pci registered [ 10.286080] PCI: PCI BIOS revision 2.10 entry at 0xfd9b2, last bus=2 [ 10.286137] PCI: Using configuration type 1 [ 10.286190] Setting up standard PCI resources ... [ 10.328881] PCI: Probing PCI hardware (bus 00) [ 10.336758] Boot video device is 0000:00:02.0 [ 10.337473] PCI quirk: region 1000-107f claimed by ICH4 ACPI/GPIO/TCO [ 10.337535] PCI quirk: region 1180-11bf claimed by ICH4 GPIO [ 10.337675] PCI: Ignoring BAR0-3 of IDE controller 0000:00:1f.1 [ 10.338637] PCI: Firmware left 0000:02:08.0 e100 interrupts enabled, disabling [ 10.338813] PCI: Transparent bridge - 0000:00:1e.0 [ 10.339136] PCI: Bus #03 (-#06) is hidden behind transparent bridge #02 (-#02) (try 'pci=assign-busses') [ 10.339213] Please report the result to linux-kernel to fix this permanently [ 10.339527] PCI: Bus #07 (-#0a) is hidden behind transparent bridge #02 (-#02) (try 'pci=assign-busses') [ 10.339605] Please report the result to linux-kernel to fix this permanently [ 10.339694] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 10.369585] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT] [ 10.374175] ACPI: PCI Interrupt Link [LNKA] (IRQs *10) [ 10.375301] ACPI: PCI Interrupt Link [LNKB] (IRQs *10) [ 10.376400] ACPI: PCI Interrupt Link [LNKC] (IRQs *11) [ 10.377546] ACPI: PCI Interrupt Link [LNKD] (IRQs *11) [ 10.378651] ACPI: PCI Interrupt Link [LNKE] (IRQs *5) [ 10.379740] ACPI: PCI Interrupt Link [LNKF] (IRQs 5) *0, disabled. [ 10.380933] ACPI: PCI Interrupt Link [LNKG] (IRQs 10) *0, disabled. [ 10.382172] ACPI: PCI Interrupt Link [LNKH] (IRQs *10) [ 10.392529] ACPI: Power Resource [PFAN] (on) [ 10.394992] SCSI subsystem initialized [ 10.395223] libata version 2.00 loaded. [ 10.395617] usbcore: registered new interface driver usbfs [ 10.395940] usbcore: registered new interface driver hub [ 10.396326] usbcore: registered new device driver usb [ 10.397025] PCI: Using ACPI for IRQ routing [ 10.397079] PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report ... [ 10.406006] PCI: Ignore bogus resource 6 [0:0] of 0000:00:02.0 [ 10.406103] PCI: Bus 3, cardbus bridge: 0000:02:03.0 [ 10.406158] IO window: 00003400-000034ff [ 10.406214] IO window: 00003800-000038ff [ 10.406269] PREFETCH window: 40000000-41ffffff [ 10.406326] MEM window: 46000000-47ffffff [ 10.406402] PCI: Bus 7, cardbus bridge: 0000:02:03.1 [ 10.406456] IO window: 00003c00-00003cff [ 10.406512] IO window: 00001400-000014ff [ 10.406567] PREFETCH window: 42000000-43ffffff [ 10.406623] MEM window: 48000000-49ffffff [ 10.406678] PCI: Bridge: 0000:00:1e.0 [ 10.406731] IO window: 3000-3fff [ 10.406787] MEM window: e0200000-e02fffff [ 10.406843] PREFETCH window: 40000000-43ffffff [ 10.406913] PCI: Setting latency timer of device 0000:00:1e.0 to 64 [ 10.407627] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10 [ 10.407686] PCI: setting IRQ 10 as level-triggered [ 10.407690] ACPI: PCI Interrupt 0000:02:03.0[A] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10 [ 10.407829] PCI: Setting latency timer of device 0000:02:03.0 to 64 [ 10.407848] PCI: Enabling device 0000:02:03.1 (0000 -> 0003) [ 10.408521] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10 [ 10.408578] ACPI: PCI Interrupt 0000:02:03.1[B] -> Link [LNKB] -> GSI 10 (level, low) -> IRQ 10 [ 10.408717] PCI: Setting latency timer of device 0000:02:03.1 to 64 ... [ 10.445445] pci 0000:00:1d.0: uhci_check_and_reset_hc: legsup = 0x2f00 [ 10.445448] pci 0000:00:1d.0: Performing full reset [ 10.445468] pci 0000:00:1d.1: uhci_check_and_reset_hc: legsup = 0x2000 [ 10.445471] pci 0000:00:1d.1: Performing full reset [ 10.445490] pci 0000:00:1d.2: uhci_check_and_reset_hc: legsup = 0x2000 [ 10.445493] pci 0000:00:1d.2: Performing full reset ... [ 12.876533] Bluetooth: HCI USB driver ver 2.9 [ 12.876801] usbcore: registered new interface driver hci_usb [ 12.877200] Advanced Linux Sound Architecture Driver Version 1.0.13 (Tue Nov 28 14:07:24 2006 UTC). [ 12.879855] ACPI: PCI Interrupt 0000:00:1f.5[B] -> Link [LNKB] -> GSI 10 (level, low) -> IRQ 10 [ 12.880028] PCI: Setting latency timer of device 0000:00:1f.5 to 64 [ 12.899128] input: AT Translated Set 2 keyboard as /class/input/input1 [ 13.535251] input: ImPS/2 Synaptics TouchPad as /class/input/input2 [ 13.694284] intel8x0_measure_ac97_clock: measured 50992 usecs [ 13.694342] intel8x0: clocking to 48000 [ 13.699676] ACPI: PCI Interrupt 0000:00:1f.6[B] -> Link [LNKB] -> GSI 10 (level, low) -> IRQ 10 [ 13.699830] PCI: Setting latency timer of device 0000:00:1f.6 to 64 [ 13.801179] MC'97 1 converters and GPIO not ready (0xf000) [ 13.803867] usbcore: registered new interface driver snd-usb-audio [ 13.803926] ALSA device list: [ 13.803976] #0: Intel 82801DB-ICH4 with STAC9752,53 at 0xe0100c00, irq 10 [ 13.804034] #1: Intel 82801DB-ICH4 Modem at 0x2400, irq 10 ... [ 13.929847] VFS: Mounted root (ext3 filesystem) readonly. [ 13.930140] Freeing unused kernel memory: 168k freed [ 13.930283] Write protecting the kernel read-only data: 556k [ 22.229058] USB Universal Host Controller Interface driver v3.0 [ 22.236270] ACPI: PCI Interrupt 0000:00:1d.0[A] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10 [ 22.236293] PCI: Setting latency timer of device 0000:00:1d.0 to 64 [ 22.236300] uhci_hcd 0000:00:1d.0: UHCI Host Controller [ 22.244925] drivers/usb/core/inode.c: creating file 'devices' [ 22.245065] drivers/usb/core/inode.c: creating file '001' [ 22.245260] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1 [ 22.245286] uhci_hcd 0000:00:1d.0: detected 2 ports [ 22.245296] uhci_hcd 0000:00:1d.0: uhci_check_and_reset_hc: cmd = 0x0000 [ 22.245299] uhci_hcd 0000:00:1d.0: Performing full reset [ 22.245324] uhci_hcd 0000:00:1d.0: irq 10, io base 0x00001820 [ 22.246077] usb usb1: default language 0x0409 [ 22.246124] usb usb1: new device strings: Mfr=3, Product=2, SerialNumber=1 [ 22.246128] usb usb1: Product: UHCI Host Controller [ 22.246131] usb usb1: Manufacturer: Linux 2.6.19 uhci_hcd [ 22.246134] usb usb1: SerialNumber: 0000:00:1d.0 [ 22.246473] usb usb1: uevent [ 22.252780] usb usb1: usb_probe_device [ 22.259984] usb usb1: configuration #1 chosen from 1 choice [ 22.260448] usb usb1: adding 1-0:1.0 (config #1, interface 0) [ 22.260645] usb 1-0:1.0: uevent [ 22.266993] hub 1-0:1.0: usb_probe_interface [ 22.266996] hub 1-0:1.0: usb_probe_interface - got id [ 22.267002] hub 1-0:1.0: USB hub found [ 22.267434] hub 1-0:1.0: 2 ports detected [ 22.267437] hub 1-0:1.0: standalone hub [ 22.267439] hub 1-0:1.0: no power switching (usb 1.0) [ 22.267443] hub 1-0:1.0: individual port over-current protection [ 22.267447] hub 1-0:1.0: power on to power good time: 2ms [ 22.267470] hub 1-0:1.0: local power source is good [ 22.267476] hub 1-0:1.0: trying to enable port power on non-switchable hub [ 22.308082] ehci_hcd: block sizes: qh 128 qtd 96 itd 192 sitd 96 [ 22.368260] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000 [ 22.382636] drivers/usb/core/inode.c: creating file '001' [ 22.382752] uhci_hcd 0000:00:1d.0: port 1 portsc 009b,00 [ 22.382779] hub 1-0:1.0: port 1, status 0101, change 0003, 12 Mb/s [ 22.383857] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11 [ 22.383863] ACPI: PCI Interrupt 0000:00:1d.1[B] -> Link [LNKD] -> GSI 11 (level, low) -> IRQ 11 [ 22.383885] PCI: Setting latency timer of device 0000:00:1d.1 to 64 [ 22.383892] uhci_hcd 0000:00:1d.1: UHCI Host Controller [ 22.390270] drivers/usb/core/inode.c: creating file '002' [ 22.390323] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2 [ 22.390344] uhci_hcd 0000:00:1d.1: detected 2 ports [ 22.390352] uhci_hcd 0000:00:1d.1: uhci_check_and_reset_hc: cmd = 0x0000 [ 22.390356] uhci_hcd 0000:00:1d.1: Performing full reset [ 22.390383] uhci_hcd 0000:00:1d.1: irq 11, io base 0x00001840 [ 22.390557] usb usb2: default language 0x0409 [ 22.390601] usb usb2: new device strings: Mfr=3, Product=2, SerialNumber=1 [ 22.390605] usb usb2: Product: UHCI Host Controller [ 22.390608] usb usb2: Manufacturer: Linux 2.6.19 uhci_hcd [ 22.390611] usb usb2: SerialNumber: 0000:00:1d.1 [ 22.390785] usb usb2: uevent [ 22.397046] usb usb2: usb_probe_device [ 22.403649] usb usb2: configuration #1 chosen from 1 choice [ 22.403682] usb usb2: adding 2-0:1.0 (config #1, interface 0) [ 22.403828] usb 2-0:1.0: uevent [ 22.409994] hub 2-0:1.0: usb_probe_interface [ 22.409998] hub 2-0:1.0: usb_probe_interface - got id [ 22.410003] hub 2-0:1.0: USB hub found [ 22.410027] hub 2-0:1.0: 2 ports detected [ 22.410030] hub 2-0:1.0: standalone hub [ 22.410033] hub 2-0:1.0: no power switching (usb 1.0) [ 22.410036] hub 2-0:1.0: individual port over-current protection [ 22.410041] hub 2-0:1.0: power on to power good time: 2ms [ 22.410062] hub 2-0:1.0: local power source is good [ 22.410068] hub 2-0:1.0: trying to enable port power on non-switchable hub [ 22.486350] hub 1-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x101 [ 22.555864] drivers/usb/core/inode.c: creating file '001' [ 22.556028] ACPI: PCI Interrupt 0000:00:1d.2[C] -> Link [LNKC] -> GSI 11 (level, low) -> IRQ 11 [ 22.556052] PCI: Setting latency timer of device 0000:00:1d.2 to 64 [ 22.556059] uhci_hcd 0000:00:1d.2: UHCI Host Controller [ 22.562311] drivers/usb/core/inode.c: creating file '003' [ 22.562365] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 3 [ 22.562390] uhci_hcd 0000:00:1d.2: detected 2 ports [ 22.562398] uhci_hcd 0000:00:1d.2: uhci_check_and_reset_hc: cmd = 0x0000 [ 22.562402] uhci_hcd 0000:00:1d.2: Performing full reset [ 22.562426] uhci_hcd 0000:00:1d.2: irq 11, io base 0x00001860 [ 22.562592] usb usb3: default language 0x0409 [ 22.562636] usb usb3: new device strings: Mfr=3, Product=2, SerialNumber=1 [ 22.562639] usb usb3: Product: UHCI Host Controller [ 22.562643] usb usb3: Manufacturer: Linux 2.6.19 uhci_hcd [ 22.562646] usb usb3: SerialNumber: 0000:00:1d.2 [ 22.562840] usb usb3: uevent [ 22.568878] usb usb3: usb_probe_device [ 22.575121] usb usb3: configuration #1 chosen from 1 choice [ 22.575155] usb usb3: adding 3-0:1.0 (config #1, interface 0) [ 22.575317] usb 3-0:1.0: uevent [ 22.581383] hub 3-0:1.0: usb_probe_interface [ 22.581387] hub 3-0:1.0: usb_probe_interface - got id [ 22.581393] hub 3-0:1.0: USB hub found [ 22.581418] hub 3-0:1.0: 2 ports detected [ 22.581421] hub 3-0:1.0: standalone hub [ 22.581424] hub 3-0:1.0: no power switching (usb 1.0) [ 22.581427] hub 3-0:1.0: individual port over-current protection [ 22.581432] hub 3-0:1.0: power on to power good time: 2ms [ 22.581453] hub 3-0:1.0: local power source is good [ 22.581459] hub 3-0:1.0: trying to enable port power on non-switchable hub [ 22.588360] usb 1-1: new full speed USB device using uhci_hcd and address 2 [ 22.689367] drivers/usb/core/inode.c: creating file '001' [ 22.703207] ACPI: PCI Interrupt Link [LNKH] enabled at IRQ 10 [ 22.703214] ACPI: PCI Interrupt 0000:00:1d.7[D] -> Link [LNKH] -> GSI 10 (level, low) -> IRQ 10 [ 22.703242] PCI: Setting latency timer of device 0000:00:1d.7 to 64 [ 22.703249] ehci_hcd 0000:00:1d.7: EHCI Host Controller [ 22.703439] drivers/usb/core/inode.c: creating file '004' [ 22.703491] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 4 [ 22.703514] ehci_hcd 0000:00:1d.7: reset hcs_params 0x103206 dbg=1 cc=3 pcc=2 ordered !ppc ports=6 [ 22.703520] ehci_hcd 0000:00:1d.7: reset hcc_params 6871 thresh 7 uframes 1024 64 bit addr [ 22.703596] ehci_hcd 0000:00:1d.7: debug port 1 [ 22.703606] PCI: cache line size of 32 is not supported by device 0000:00:1d.7 [ 22.703610] ehci_hcd 0000:00:1d.7: supports USB remote wakeup [ 22.703622] ehci_hcd 0000:00:1d.7: irq 10, io mem 0xe0100000 [ 22.703629] ehci_hcd 0000:00:1d.7: reset command 080002 (park)=0 ithresh=8 period=1024 Reset HALT [ 22.707519] ehci_hcd 0000:00:1d.7: init command 010001 (park)=0 ithresh=1 period=1024 RUN [ 22.707526] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 [ 22.707601] usb usb4: default language 0x0409 [ 22.707645] usb usb4: new device strings: Mfr=3, Product=2, SerialNumber=1 [ 22.707649] usb usb4: Product: EHCI Host Controller [ 22.707652] usb usb4: Manufacturer: Linux 2.6.19 ehci_hcd [ 22.707656] usb usb4: SerialNumber: 0000:00:1d.7 [ 22.707822] usb usb4: uevent [ 22.707887] usb usb4: usb_probe_device [ 22.708257] usb usb4: configuration #1 chosen from 1 choice [ 22.708287] usb usb4: adding 4-0:1.0 (config #1, interface 0) [ 22.708433] usb 4-0:1.0: uevent [ 22.708500] hub 4-0:1.0: usb_probe_interface [ 22.708503] hub 4-0:1.0: usb_probe_interface - got id [ 22.708508] hub 4-0:1.0: USB hub found [ 22.708835] hub 4-0:1.0: 6 ports detected [ 22.708838] hub 4-0:1.0: standalone hub [ 22.708841] hub 4-0:1.0: no power switching (usb 1.0) [ 22.708844] hub 4-0:1.0: individual port over-current protection [ 22.708848] hub 4-0:1.0: Single TT [ 22.708851] hub 4-0:1.0: TT requires at most 8 FS bit times (666 ns) [ 22.708855] hub 4-0:1.0: power on to power good time: 20ms [ 22.708878] hub 4-0:1.0: local power source is good [ 22.708884] hub 4-0:1.0: trying to enable port power on non-switchable hub [ 22.715984] usb 1-1: uhci_result_common: failed with status 440000 [ 22.716056] usb 1-1: device descriptor read/all, error -71 [ 22.769085] uhci_hcd 0000:00:1d.0: port 2 portsc 008a,00 [ 22.769111] hub 1-0:1.0: port 2, status 0100, change 0003, 12 Mb/s [ 22.815938] drivers/usb/core/inode.c: creating file '001' [ 22.828262] ACPI: PCI Interrupt 0000:00:1f.3[B] -> Link [LNKB] -> GSI 10 (level, low) -> IRQ 10 [ 22.872871] hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 [ 22.872881] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0002 [ 22.872971] hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0000 [ 22.873000] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000 [ 22.873026] hub 4-0:1.0: state 7 ports 6 chg 0000 evt 0000 [ 22.873043] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001803 POWER sig=j CSC CONNECT [ 22.873061] hub 4-0:1.0: port 1, status 0501, change 0001, 480 Mb/s [ 22.890056] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled [ 22.976743] hub 4-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x501 [ 23.027893] ehci_hcd 0000:00:1d.7: port 1 high speed [ 23.027902] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 23.078627] usb 4-1: new high speed USB device using ehci_hcd and address 2 [ 23.131760] ehci_hcd 0000:00:1d.7: port 1 high speed [ 23.131767] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 23.198592] usb 4-1: default language 0x0409 [ 23.217949] usb 4-1: new device strings: Mfr=1, Product=2, SerialNumber=3 [ 23.217955] usb 4-1: Product: ATAPI-6 Bridge Controller [ 23.217958] usb 4-1: Manufacturer: Prolific Technology Inc. [ 23.217962] usb 4-1: SerialNumber: 12C3032B [ 23.218129] usb 4-1: uevent [ 23.218186] usb 4-1: usb_probe_device [ 23.218524] usb 4-1: configuration #1 chosen from 1 choice [ 23.218942] usb 4-1: adding 4-1:1.0 (config #1, interface 0) [ 23.219079] usb 4-1:1.0: uevent [ 23.219951] drivers/usb/core/inode.c: creating file '002' [ 23.220030] ehci_hcd 0000:00:1d.7: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT [ 23.220050] hub 4-0:1.0: port 2, status 0501, change 0001, 480 Mb/s [ 23.323310] hub 4-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 [ 23.374456] ehci_hcd 0000:00:1d.7: port 2 full speed --> companion [ 23.374465] ehci_hcd 0000:00:1d.7: GetStatus port 2 status 003801 POWER OWNER sig=j CONNECT [ 23.374555] hub 4-0:1.0: state 7 ports 6 chg 0000 evt 0000 [ 23.381230] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0004 [ 23.381246] uhci_hcd 0000:00:1d.0: port 2 portsc 0093,00 [ 23.381262] hub 1-0:1.0: port 2, status 0101, change 0001, 12 Mb/s [ 23.485113] hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 [ 23.554005] usb usb2: suspend_rh (auto-stop) [ 23.586992] usb 1-2: new full speed USB device using uhci_hcd and address 4 [ 23.627991] ieee1394: Initialized config rom entry `ip1394' [ 23.687838] usb usb3: suspend_rh (auto-stop) [ 23.707805] usb 1-2: ep0 maxpacket = 8 [ 23.729738] usb 1-2: default language 0x0409 [ 23.744707] usb 1-2: new device strings: Mfr=1, Product=2, SerialNumber=0 [ 23.744714] usb 1-2: Product: Generic USB Hub [ 23.744717] usb 1-2: Manufacturer: ALCOR [ 23.744931] usb 1-2: uevent [ 23.744992] usb 1-2: usb_probe_device [ 23.745264] usb 1-2: configuration #1 chosen from 1 choice [ 23.747703] usb 1-2: adding 1-2:1.0 (config #1, interface 0) [ 23.747861] usb 1-2:1.0: uevent [ 23.747914] hub 1-2:1.0: usb_probe_interface [ 23.747918] hub 1-2:1.0: usb_probe_interface - got id [ 23.747923] hub 1-2:1.0: USB hub found [ 23.750806] hub 1-2:1.0: 4 ports detected [ 23.750809] hub 1-2:1.0: standalone hub [ 23.750812] hub 1-2:1.0: individual port power switching [ 23.750816] hub 1-2:1.0: individual port over-current protection [ 23.750820] hub 1-2:1.0: power on to power good time: 44ms [ 23.752700] hub 1-2:1.0: local power source is good [ 23.752706] hub 1-2:1.0: enabling power on all ports [ 23.798317] ACPI: PCI Interrupt 0000:02:03.2[C] -> Link [LNKC] -> GSI 11 (level, low) -> IRQ 11 [ 23.853438] ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[11] MMIO=[e0202000-e02027ff] Max Packet=[2048] IR/IT contexts=[4/4] [ 23.857984] drivers/usb/core/inode.c: creating file '004' [ 23.858061] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0004 [ 23.858089] hub 1-2:1.0: state 7 ports 4 chg 0000 evt 0000 [ 23.861859] hub 1-2:1.0: port 2, status 0101, change 0001, 12 Mb/s [ 23.901592] Yenta: CardBus bridge found at 0000:02:03.0 [144d:c009] [ 23.971448] hub 1-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 [ 24.023966] Yenta: ISA IRQ mask 0x0098, PCI irq 10 [ 24.023972] Socket status: 30000006 [ 24.023976] Yenta: Raising subordinate bus# of parent bus (#02) from #02 to #06 [ 24.023994] pcmcia: parent PCI bridge I/O window: 0x3000 - 0x3fff [ 24.024225] cs: IO port probe 0x3000-0x3fff: clean. [ 24.026040] pcmcia: parent PCI bridge Memory window: 0xe0200000 - 0xe02fffff [ 24.026046] pcmcia: parent PCI bridge Memory window: 0x40000000 - 0x43ffffff [ 24.026855] Yenta: CardBus bridge found at 0000:02:03.1 [144d:c009] [ 24.036361] usb 1-2.2: new full speed USB device using uhci_hcd and address 5 [ 24.136252] usb 1-2.2: skipped 16 descriptors after interface [ 24.136276] usb 1-2.2: skipped 2 descriptors after interface [ 24.136281] usb 1-2.2: skipped 1 descriptor after endpoint [ 24.136286] usb 1-2.2: skipped 2 descriptors after interface [ 24.136291] usb 1-2.2: skipped 1 descriptor after endpoint [ 24.141221] usb 1-2.2: default language 0x0409 [ 24.146225] usb 1-2.2: new device strings: Mfr=0, Product=1, SerialNumber=0 [ 24.146231] usb 1-2.2: Product: USB Audio [ 24.146457] usb 1-2.2: uevent [ 24.146511] usb 1-2.2: usb_probe_device [ 24.146804] usb 1-2.2: configuration #1 chosen from 1 choice [ 24.148822] Yenta: ISA IRQ mask 0x0098, PCI irq 10 [ 24.148826] Socket status: 30000006 [ 24.148831] Yenta: Raising subordinate bus# of parent bus (#02) from #06 to #0a [ 24.148848] pcmcia: parent PCI bridge I/O window: 0x3000 - 0x3fff [ 24.148854] cs: IO port probe 0x3000-0x3fff:<7>usb 1-2.2: adding 1-2.2:1.0 (config #1, interface 0) [ 24.149480] usb 1-2.2:1.0: uevent [ 24.149541] snd-usb-audio 1-2.2:1.0: usb_probe_interface [ 24.149546] snd-usb-audio 1-2.2:1.0: usb_probe_interface - got id [ 24.149992] 5:1:1: add audio endpoint 0x1 [ 24.152261] clean. [ 24.152265] pcmcia: parent PCI bridge Memory window: 0xe0200000 - 0xe02fffff [ 24.152271] pcmcia: parent PCI bridge Memory window: 0x40000000 - 0x43ffffff [ 24.153327] 5:2:1: add audio endpoint 0x82 [ 24.265776] ipw2100: Intel(R) PRO/Wireless 2100 Network Driver, git-1.2.2 [ 24.265782] ipw2100: Copyright(c) 2003-2006 Intel Corporation [ 24.266741] ACPI: PCI Interrupt 0000:02:07.0[A] -> Link [LNKE] -> GSI 5 (level, low) -> IRQ 5 [ 24.274343] ipw2100: Detected Intel PRO/Wireless 2100 Network Connection [ 24.614658] [13] FU [Mic Playback Switch] ch = 1, val = 0/1/1 [ 24.627606] cannot set ctl value: req = 0x4, wValue = 0x200, wIndex = 0xd00, type = 4, data = 0x18/0x0 [ 24.631605] [13] FU [Mic Playback Volume] ch = 1, val = 0/12240/48 [ 24.631626] [14] FU [Line Playback Switch] ch = 1, val = 0/1/1 [ 24.644582] cannot set ctl value: req = 0x4, wValue = 0x201, wIndex = 0xe00, type = 4, data = 0x18/0x0 [ 24.649580] [14] FU [Line Playback Volume] ch = 2, val = 0/12240/48 [ 24.649599] [9] FU [Master Playback Switch] ch = 1, val = 0/1/1 [ 24.662564] cannot set ctl value: req = 0x4, wValue = 0x201, wIndex = 0x900, type = 4, data = 0x18/0x0 [ 24.667575] [9] FU [Master Playback Volume] ch = 2, val = -12256/-16/48 [ 24.667623] [10] FU [Mic Capture Switch] ch = 1, val = 0/1/1 [ 24.680543] cannot set ctl value: req = 0x4, wValue = 0x200, wIndex = 0xa00, type = 4, data = 0x18/0x0 [ 24.685537] [10] FU [Mic Capture Volume] ch = 1, val = -48/6096/48 [ 24.685554] [10] FU [Mic Boost] ch = 1, val = 0/1/1 [ 24.685567] [11] FU [Line Capture Switch] ch = 1, val = 0/1/1 [ 24.698518] cannot set ctl value: req = 0x4, wValue = 0x201, wIndex = 0xb00, type = 4, data = 0x18/0x0 [ 24.703522] [11] FU [Line Capture Volume] ch = 2, val = -48/6096/48 [ 24.703543] [12] FU [Digital In Playback Switch] ch = 1, val = 0/1/1 [ 24.703597] [8] SU [Capture Input Source] items = 3 [ 24.705541] usb 1-2.2: adding 1-2.2:1.1 (config #1, interface 1) [ 24.705720] usb 1-2.2:1.1: uevent [ 24.705846] usb 1-2.2: adding 1-2.2:1.2 (config #1, interface 2) [ 24.705990] usb 1-2.2:1.2: uevent [ 24.706279] drivers/usb/core/inode.c: creating file '005' [ 24.708502] hub 1-2:1.0: state 7 ports 4 chg 0000 evt 0004 [ 24.870406] hub 2-0:1.0: hub_suspend [ 24.870493] usb usb2: suspend_rh [ 24.870884] usb usb2: usb auto-suspend [ 24.870950] hub 3-0:1.0: hub_suspend [ 24.870954] usb usb3: suspend_rh [ 24.870965] usb usb3: usb auto-suspend [ 25.123613] ieee1394: Host added: ID:BUS[0-00:1023] GUID[0000f0414001c880] [ 25.217333] usb 4-1: usb auto-suspend [ 25.371786] hub 4-0:1.0: hub_suspend [ 25.371979] usb usb4: usb auto-suspend [ 26.125010] cs: IO port probe 0xc00-0xcff: clean. [ 26.125931] cs: IO port probe 0x800-0x8ff:<3>irq 10: nobody cared (try booting with the "irqpoll" option) [ 28.956096] [<c01034ee>] dump_trace+0x64/0x1d0 [ 28.956109] [<c0103674>] show_trace_log_lvl+0x1a/0x2f [ 28.956117] [<c0103d29>] show_trace+0x12/0x14 [ 28.956123] [<c0103dcc>] dump_stack+0x19/0x1b [ 28.956130] [<c0141525>] __report_bad_irq+0x39/0x81 [ 28.956139] [<c0141706>] note_interrupt+0x199/0x1d3 [ 28.956146] [<c0141f80>] handle_level_irq+0xa3/0xdf [ 28.956154] [<c0104ef8>] do_IRQ+0xcb/0xf7 [ 28.956161] [<c01030b9>] common_interrupt+0x25/0x2c [ 28.956172] [<c011bf29>] __do_softirq+0x4c/0xb0 [ 28.956181] [<c0104dbf>] do_softirq+0x5b/0xc9 [ 28.956188] [<c011bed1>] irq_exit+0x3f/0x4b [ 28.956194] [<c0104f0c>] do_IRQ+0xdf/0xf7 [ 28.956201] [<c01030b9>] common_interrupt+0x25/0x2c [ 28.956210] [<f00783dd>] adjust_io+0xfd/0x2a6 [rsrc_nonstatic] [ 28.956227] [<f0079193>] store_io_db+0x93/0xb3 [rsrc_nonstatic] [ 28.956240] [<c0274243>] class_device_attr_store+0x1d/0x22 [ 28.956250] [<c018e4bc>] sysfs_write_file+0xab/0xd2 [ 28.956260] [<c015d5c9>] vfs_write+0x90/0x149 [ 28.956270] [<c015db4f>] sys_write+0x3d/0x61 [ 28.956277] [<c0102e4d>] sysenter_past_esp+0x56/0x8d [ 28.956285] [<b7f29410>] 0xb7f29410 [ 28.956291] ======================= [ 28.956293] handlers: [ 28.956295] [<c03048c6>] (snd_intel8x0_interrupt+0x0/0x1d5) [ 28.956306] [<c03067bd>] (snd_intel8x0_interrupt+0x0/0x1a4) [ 28.956312] [<c02bb774>] (usb_hcd_irq+0x0/0x51) [ 28.956319] [<c02bb774>] (usb_hcd_irq+0x0/0x51) [ 28.956324] [<f015d4fe>] (yenta_interrupt+0x0/0xb7 [yenta_socket]) [ 28.956336] [<f015d4fe>] (yenta_interrupt+0x0/0xb7 [yenta_socket]) [ 28.956345] Disabling IRQ #10 [ 29.084240] excluding 0x800-0x80f [ 29.085046] cs: IO port probe 0x100-0x4ff: excluding 0x4d0-0x4d7 [ 29.088610] cs: IO port probe 0xa00-0xaff: clean. [ 29.091813] cs: IO port probe 0xc00-0xcff: clean. [ 29.092741] cs: IO port probe 0x800-0x8ff: excluding 0x800-0x80f [ 29.097742] cs: IO port probe 0x100-0x4ff: excluding 0x4d0-0x4d7 [ 29.102263] cs: IO port probe 0xa00-0xaff: clean. [ 30.977674] Initializing USB Mass Storage driver... [ 30.978884] usb-storage 4-1:1.0: usb_probe_interface [ 30.978891] usb-storage 4-1:1.0: usb_probe_interface - got id [ 30.978907] usb usb4: usb auto-resume [ 30.978910] usb usb4: finish resume [ 30.979185] hub 4-0:1.0: hub_resume [ 30.979194] ehci_hcd 0000:00:1d.7: resume root hub [ 31.009825] hub 4-0:1.0: state 7 ports 6 chg 0000 evt 0000 [ 31.009855] usb 4-1: usb auto-resume [ 31.035720] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 31.046657] usb 4-1: finish resume [ 36.040436] usb 4-1: modprobe timed out on ep0in len=0/2 [ 36.050614] usb 4-1: gone after usb resume? status -110 [ 36.050620] hub 4-0:1.0: logical disconnect on port 1 [ 36.050648] usb 4-1: can't resume, status -110 [ 36.050675] hub 4-0:1.0: port 1, status 0501, change 0000, 480 Mb/s [ 36.050680] usb 4-1: USB disconnect, address 2 [ 36.050687] usb-storage: probe of 4-1:1.0 failed with error -110 [ 36.050723] usb 4-1: unregistering device [ 36.050727] usb 4-1: usb_disable_device nuking all URBs [ 36.050743] usb 4-1: unregistering interface 4-1:1.0 [ 36.051102] usbdev4.2_ep01: ep_device_release called for usbdev4.2_ep01 [ 36.051372] usbdev4.2_ep82: ep_device_release called for usbdev4.2_ep82 [ 36.051638] usb 4-1:1.0: uevent [ 36.053138] usbdev4.2_ep00: ep_device_release called for usbdev4.2_ep00 [ 36.053437] usb 4-1: uevent [ 36.058222] usbcore: registered new interface driver usb-storage [ 36.058229] USB Mass Storage support registered. [ 36.104577] ehci_hcd 0000:00:1d.7: port 1 high speed [ 36.104586] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 36.155320] usb 4-1: new high speed USB device using ehci_hcd and address 4 [ 37.154046] usb 4-1: khubd timed out on ep0in len=0/64 [ 37.215176] ehci_hcd 0000:00:1d.7: port 1 high speed [ 37.215183] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 38.007191] EXT3 FS on hda5, internal journal [ 38.444438] ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3]) [ 38.444450] ACPI: Processor [CPU0] (supports 8 throttling states) [ 28.389000] Time: acpi_pm clocksource has been installed. [ 28.480000] acpi_processor-0740 [00] processor_preregister_: Error while parsing _PSD domain information. Assuming no coordination [ 29.672000] kjournald starting. Commit interval 5 seconds [ 29.690000] EXT3 FS on hda9, internal journal [ 29.690000] EXT3-fs: mounted filesystem with ordered data mode. [ 29.826000] Adding 1004020k swap on /dev/hda8. Priority:-1 extents:1 across:1004020k [ 32.198000] usb 4-1: khubd timed out on ep0out len=0/0 [ 37.409000] usb 4-1: khubd timed out on ep0out len=0/0 [ 37.620000] usb 4-1: device not accepting address 4, error -110 [ 37.671000] ehci_hcd 0000:00:1d.7: port 1 high speed [ 37.671000] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 37.722000] usb 4-1: new high speed USB device using ehci_hcd and address 5 [ 37.829000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 37.997000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 38.247000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 38.497000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 38.722000] usb 4-1: khubd timed out on ep0in len=0/64 [ 38.747000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 38.783000] ehci_hcd 0000:00:1d.7: port 1 high speed [ 38.783000] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 38.997000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 39.247000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 39.497000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 39.747000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 39.997000] usb 1-2.2: alsactl timed out on ep0in len=-8/1 [ 40.147000] cannot get ctl value: req = 0x81, wValue = 0x100, wIndex = 0xd00, type = 1 [ 43.834000] usb 4-1: khubd timed out on ep0out len=0/0 [ 49.045000] usb 4-1: khubd timed out on ep0out len=0/0 [ 49.256000] usb 4-1: device not accepting address 5, error -110 [ 49.307000] ehci_hcd 0000:00:1d.7: port 1 high speed [ 49.307000] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 49.358000] usb 4-1: new high speed USB device using ehci_hcd and address 6 [ 54.358000] usb 4-1: khubd timed out on ep0out len=0/0 [ 59.569000] usb 4-1: khubd timed out on ep0out len=0/0 [ 59.780000] usb 4-1: device not accepting address 6, error -110 [ 59.831000] ehci_hcd 0000:00:1d.7: port 1 high speed [ 59.831000] ehci_hcd 0000:00:1d.7: GetStatus port 1 status 001005 POWER sig=se0 PE CONNECT [ 59.882000] usb 4-1: new high speed USB device using ehci_hcd and address 7 [ 64.882000] usb 4-1: khubd timed out on ep0out len=0/0 [ 70.093000] usb 4-1: khubd timed out on ep0out len=0/0 [ 70.304000] usb 4-1: device not accepting address 7, error -110 [ 70.304000] hub 4-0:1.0: state 7 ports 6 chg 0000 evt 0000 [ 72.304000] hub 4-0:1.0: hub_suspend [ 72.304000] usb usb4: usb auto-suspend [ 77.936000] setting usb interface 1:1 [ 78.420000] usbdev1.5_ep01: ep_device_release called for usbdev1.5_ep01 ------------------------------------------------------------------------- Take Surveys. Earn Cash. Influence the Future of IT Join SourceForge.net's Techsay panel and you'll get the chance to share your opinions on IT & business topics through brief surveys - and earn cash http://www.techsay.com/default.php?page=join.php&p=sourceforge&CID=DEVDEV _______________________________________________ linux-usb-devel@lists.sourceforge.net To unsubscribe, use the last form field at: https://lists.sourceforge.net/lists/listinfo/linux-usb-devel