Message-ID: <4F9F02A0.9020207@fold.natur.cuni.cz>
Date:	Mon, 30 Apr 2012 23:22:40 +0200
From:	Martin Mokrejs <mmokrejs@...d.natur.cuni.cz>
To:	linux-pci@...r.kernel.org, Yinghai Lu <yinghai@...nel.org>,
	Sarah Sharp <sarah.a.sharp@...ux.intel.com>,
	LKML <linux-kernel@...r.kernel.org>
Subject: linux-3.4-rc5: Oops in klist_del()

Hi,
  I was removing an ExpressCard with a NEC chipset used by xhci_hcd and the kernel crashed
on my Dell Vostro 3550 laptop. Its express slot chipset somehow does not report properly
that a card was unplugged, as discussed earlier here on linux-pci under Subject
"Re: 3.2.11: PCI Express card cannot be re-detected withing cca 60sec timeframe".

  Maybe this helps somebody to find the cause? Here is a bit of the attached Oops snapshot
stacktrace:

klist_del
fdevice_del
device_unregister
pci_stop_bus_device
pci_stop_and_remove_bus_device
devehp_unconfigure_device
pciehp_disable_slot
? pciehp_disable_slot
pciehp_power_thread
process_one_work
worker_thriad
? manage_workers.clone
? manage_workers.clone
kthrerd
...




Here is the very end of the /var/log/message before the crash happened:


[...]
Apr 30 22:45:17 vostro kernel: [ 1234.903961] usb 1-1.1: Manufacturer: Logitech
Apr 30 22:45:17 vostro kernel: [ 1234.908518] input: Logitech USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.1/1-1.1:1.0/input/input16
Apr 30 22:45:17 vostro kernel: [ 1234.908670] generic-usb 0003:046D:C050.0003: input,hidraw1: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:1a.0-1.1/input0
Apr 30 22:45:23 vostro kernel: [ 1241.232284] usb 2-1.2: USB disconnect, device number 3
Apr 30 22:45:23 vostro kernel: [ 1241.232289] usb 2-1.2.1: USB disconnect, device number 6
Apr 30 22:46:36 vostro kernel: [ 1313.256785] usb 1-1.1: USB disconnect, device number 4
Apr 30 22:46:59 vostro kernel: [ 1337.007432] pciehp 0000:00:1c.7:pcie04: Card not present on Slot(7)
Apr 30 22:46:59 vostro kernel: [ 1337.007691] xhci_hcd 0000:11:00.0: remove, state 4
Apr 30 22:46:59 vostro kernel: [ 1337.007698] usb usb6: USB disconnect, device number 1
Apr 30 22:46:59 vostro kernel: [ 1337.007855] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 30 22:46:59 vostro kernel: [ 1337.007858] xhci_hcd 0000:11:00.0: USB bus 6 deregistered
Apr 30 22:46:59 vostro kernel: [ 1337.007902] xhci_hcd 0000:11:00.0: remove, state 1
Apr 30 22:46:59 vostro kernel: [ 1337.007909] usb usb5: USB disconnect, device number 1
Apr 30 22:46:59 vostro kernel: [ 1337.007911] usb 5-2: USB disconnect, device number 2
Apr 30 22:47:09 vostro kernel: [ 1346.239492] r8169 0000:05:00.0: eth0: link down
Apr 30 22:47:11 vostro kernel: [ 1349.032159] r8169 0000:05:00.0: eth0: link up
Apr 30 22:47:49 vostro kernel: [ 1386.930789] xhci_hcd 0000:11:00.0: Timeout while waiting for configure endpoint command
Apr 30 22:47:49 vostro kernel: [ 1386.931247] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 30 22:47:49 vostro kernel: [ 1386.931396] xhci_hcd 0000:11:00.0: USB bus 5 deregistered
Apr 30 22:47:56 vostro kernel: [ 1393.501113] usb 1-1.1: new low-speed USB device number 5 using ehci_hcd
Apr 30 22:47:56 vostro kernel: [ 1393.617777] usb 1-1.1: New USB device found, idVendor=046d, idProduct=c050
Apr 30 22:47:56 vostro kernel: [ 1393.617784] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Apr 30 22:47:56 vostro kernel: [ 1393.617791] usb 1-1.1: Product: USB-PS/2 Optical Mouse
Apr 30 22:47:56 vostro kernel: [ 1393.617797] usb 1-1.1: Manufacturer: Logitech
Apr 30 22:47:56 vostro kernel: [ 1393.622018] input: Logitech USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.1/1-1.1:1.0/input/input17
Apr 30 22:47:56 vostro kernel: [ 1393.622120] generic-usb 0003:046D:C050.0004: input,hidraw0: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:1a.0-1.1/input0
Apr 30 22:48:05 vostro kernel: [ 1402.507793] usb 2-1.2: new high-speed USB device number 8 using ehci_hcd
Apr 30 22:48:05 vostro kernel: [ 1402.619401] usb 2-1.2: New USB device found, idVendor=05e3, idProduct=0608
Apr 30 22:48:05 vostro kernel: [ 1402.619408] usb 2-1.2: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Apr 30 22:48:05 vostro kernel: [ 1402.619414] usb 2-1.2: Product: USB2.0 Hub
Apr 30 22:48:05 vostro kernel: [ 1402.619833] hub 2-1.2:1.0: USB hub found
Apr 30 22:48:05 vostro kernel: [ 1402.620256] hub 2-1.2:1.0: 4 ports detected
Apr 30 22:48:05 vostro kernel: [ 1402.897346] usb 2-1.2.1: new low-speed USB device number 9 using ehci_hcd
Apr 30 22:48:05 vostro kernel: [ 1403.015342] usb 2-1.2.1: New USB device found, idVendor=04f2, idProduct=0116
Apr 30 22:48:05 vostro kernel: [ 1403.015350] usb 2-1.2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Apr 30 22:48:05 vostro kernel: [ 1403.015357] usb 2-1.2.1: Product: USB Keyboard
Apr 30 22:48:05 vostro kernel: [ 1403.015361] usb 2-1.2.1: Manufacturer: CHICONY
Apr 30 22:48:05 vostro kernel: [ 1403.020288] input: CHICONY USB Keyboard as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2/2-1.2.1/2-1.2.1:1.0/input/input18
Apr 30 22:48:05 vostro kernel: [ 1403.020390] generic-usb 0003:04F2:0116.0005: input,hidraw1: USB HID v1.10 Keyboard [CHICONY USB Keyboard] on usb-0000:00:1d.0-1.2.1/input0
Apr 30 22:49:07 vostro kernel: [ 1464.989087] pciehp 0000:00:1c.7:pcie04: Card present on Slot(7)
Apr 30 22:49:08 vostro kernel: [ 1465.114387] pci 0000:11:00.0: BAR 0: assigned [mem 0xf6c00000-0xf6c01fff 64bit]
Apr 30 22:49:08 vostro kernel: [ 1465.114433] pcieport 0000:00:1c.7: PCI bridge to [bus 11-16]
Apr 30 22:49:08 vostro kernel: [ 1465.114437] pcieport 0000:00:1c.7:   bridge window [io  0xc000-0xdfff]
Apr 30 22:49:08 vostro kernel: [ 1465.114442] pcieport 0000:00:1c.7:   bridge window [mem 0xf6c00000-0xf7cfffff]
Apr 30 22:49:08 vostro kernel: [ 1465.114446] pcieport 0000:00:1c.7:   bridge window [mem 0xf0000000-0xf10fffff 64bit pref]
Apr 30 22:49:08 vostro kernel: [ 1465.114584] xhci_hcd 0000:11:00.0: enabling device (0100 -> 0102)
Apr 30 22:49:08 vostro kernel: [ 1465.114634] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 30 22:49:08 vostro kernel: [ 1465.114683] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 5
Apr 30 22:49:08 vostro kernel: [ 1465.115230] xhci_hcd 0000:11:00.0: irq 19, io mem 0xf6c00000
Apr 30 22:49:08 vostro kernel: [ 1465.115747] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
Apr 30 22:49:08 vostro kernel: [ 1465.115749] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 30 22:49:08 vostro kernel: [ 1465.115750] usb usb5: Product: xHCI Host Controller
Apr 30 22:49:08 vostro kernel: [ 1465.115752] usb usb5: Manufacturer: Linux 3.4.0-rc5-default xhci_hcd
Apr 30 22:49:08 vostro kernel: [ 1465.115753] usb usb5: SerialNumber: 0000:11:00.0
Apr 30 22:49:08 vostro kernel: [ 1465.115845] hub 5-0:1.0: USB hub found
Apr 30 22:49:08 vostro kernel: [ 1465.115855] hub 5-0:1.0: 2 ports detected
Apr 30 22:49:08 vostro kernel: [ 1465.115936] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 30 22:49:08 vostro kernel: [ 1465.115963] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 6
Apr 30 22:49:08 vostro kernel: [ 1465.118381] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003
Apr 30 22:49:08 vostro kernel: [ 1465.118383] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 30 22:49:08 vostro kernel: [ 1465.118385] usb usb6: Product: xHCI Host Controller
Apr 30 22:49:08 vostro kernel: [ 1465.118387] usb usb6: Manufacturer: Linux 3.4.0-rc5-default xhci_hcd
Apr 30 22:49:08 vostro kernel: [ 1465.118389] usb usb6: SerialNumber: 0000:11:00.0
Apr 30 22:49:08 vostro kernel: [ 1465.118532] hub 6-0:1.0: USB hub found
Apr 30 22:49:08 vostro kernel: [ 1465.118550] hub 6-0:1.0: 2 ports detected
Apr 30 22:49:09 vostro kernel: [ 1466.262663] usb 5-2: new high-speed USB device number 3 using xhci_hcd
Apr 30 22:49:09 vostro kernel: [ 1466.295273] usb 5-2: New USB device found, idVendor=174c, idProduct=5106
Apr 30 22:49:09 vostro kernel: [ 1466.295280] usb 5-2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Apr 30 22:49:09 vostro kernel: [ 1466.295286] usb 5-2: Product: AS2105
Apr 30 22:49:09 vostro kernel: [ 1466.295291] usb 5-2: Manufacturer: ASMedia
Apr 30 22:49:09 vostro kernel: [ 1466.295296] usb 5-2: SerialNumber:      WD-WX51C10U8155
Apr 30 22:49:09 vostro kernel: [ 1466.295475] usb 5-2: ep 0x81 - rounding interval to 32768 microframes, ep desc says 0 microframes
Apr 30 22:49:09 vostro kernel: [ 1466.295483] usb 5-2: ep 0x2 - rounding interval to 32768 microframes, ep desc says 0 microframes
Apr 30 22:49:09 vostro kernel: [ 1466.296681] scsi9 : usb-storage 5-2:1.0
Apr 30 22:49:10 vostro kernel: [ 1467.297509] scsi 9:0:0:0: Direct-Access     WDC WD10 TPVT-00HT5T0     01.0 PQ: 0 ANSI: 0
Apr 30 22:49:10 vostro kernel: [ 1467.297680] sd 9:0:0:0: Attached scsi generic sg3 type 0
Apr 30 22:49:10 vostro kernel: [ 1467.297948] sd 9:0:0:0: [sdc] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB)
Apr 30 22:49:10 vostro kernel: [ 1467.298735] sd 9:0:0:0: [sdc] Write Protect is off
Apr 30 22:49:10 vostro kernel: [ 1467.311395]  sdc: sdc1
Apr 30 22:49:10 vostro kernel: [ 1467.314100] sd 9:0:0:0: [sdc] Attached SCSI disk
Apr 30 22:49:14 vostro kernel: [ 1471.033099] pciehp 0000:00:1c.7:pcie04: Card not present on Slot(7)
Apr 30 22:49:14 vostro kernel: [ 1471.033341] xhci_hcd 0000:11:00.0: remove, state 4
Apr 30 22:49:14 vostro kernel: [ 1471.033347] usb usb6: USB disconnect, device number 1
Apr 30 22:49:14 vostro kernel: [ 1471.033481] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 30 22:49:14 vostro kernel: [ 1471.033484] xhci_hcd 0000:11:00.0: USB bus 6 deregistered
Apr 30 22:49:14 vostro kernel: [ 1471.033515] xhci_hcd 0000:11:00.0: remove, state 1
Apr 30 22:49:14 vostro kernel: [ 1471.033519] usb usb5: USB disconnect, device number 1
Apr 30 22:49:14 vostro kernel: [ 1471.033520] usb 5-2: USB disconnect, device number 3


Martin

Download attachment "P1010005_grayscale.JPG" of type "image/jpeg" (111421 bytes)

Powered by blists - more mailing lists