lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Date:	Fri, 20 Apr 2012 13:23:38 +0200
From:	Martin Mokrejs <mmokrejs@...d.natur.cuni.cz>
To:	Yinghai Lu <yinghai@...nel.org>
CC:	Sarah Sharp <sarah.a.sharp@...ux.intel.com>,
	linux-pci@...r.kernel.org,
	Linux Kernel Mailing List <linux-kernel@...r.kernel.org>
Subject: Re: 3.2.11: PCI Express card cannot be re-detected withing cca 60sec
 timeframe

Yinghai Lu wrote:
> On Thu, Apr 19, 2012 at 2:48 PM, Yinghai Lu <yinghai@...nel.org> wrote:
>> On Thu, Apr 19, 2012 at 4:16 PM, Martin Mokrejs
>>> I just tried something similar under linux, with all the patches I accumulated for 3.4-rc3
>>> and posted in my previous emails. It seems linux flips some value so on every second card
>>> removal it really does realize it was just unplugged.
>> ...
>>
>> that is really looks like silicon problem.
>>
> 
> please check attached patch. Hope link change bit is flip around...
> if there is change, we could add some logic:
>    check if the device is there, or will reset link to normal state.

I don't think it helped but maybe you will see some difference:


Apr 20 12:50:57 vostro kernel: [   94.357228] pciehp 0000:00:1c.7:pcie04: lnk_status = 7011
Apr 20 12:50:57 vostro kernel: [   94.357232] pciehp 0000:00:1c.7:pcie04: Card present on Slot(7)
Apr 20 12:50:57 vostro kernel: [   94.481210] pci 0000:11:00.0: BAR 0: assigned [mem 0xf6c00000-0xf6c01fff 64bit]
Apr 20 12:50:57 vostro kernel: [   94.481255] pcieport 0000:00:1c.7: PCI bridge to [bus 11-16]
Apr 20 12:50:57 vostro kernel: [   94.481258] pcieport 0000:00:1c.7:   bridge window [io  0xc000-0xdfff]
Apr 20 12:50:57 vostro kernel: [   94.481263] pcieport 0000:00:1c.7:   bridge window [mem 0xf6c00000-0xf7cfffff]
Apr 20 12:50:57 vostro kernel: [   94.481267] pcieport 0000:00:1c.7:   bridge window [mem 0xf0000000-0xf10fffff 64bit pref]
Apr 20 12:50:57 vostro kernel: [   94.481407] xhci_hcd 0000:11:00.0: enabling device (0100 -> 0102)
Apr 20 12:50:57 vostro kernel: [   94.481463] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 12:50:57 vostro kernel: [   94.481468] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 5
Apr 20 12:50:57 vostro kernel: [   94.481767] xhci_hcd 0000:11:00.0: irq 19, io mem 0xf6c00000
Apr 20 12:50:57 vostro kernel: [   94.482036] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
Apr 20 12:50:57 vostro kernel: [   94.482038] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 12:50:57 vostro kernel: [   94.482039] usb usb5: Product: xHCI Host Controller
Apr 20 12:50:57 vostro kernel: [   94.482040] usb usb5: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 12:50:57 vostro kernel: [   94.482041] usb usb5: SerialNumber: 0000:11:00.0
Apr 20 12:50:57 vostro kernel: [   94.482188] hub 5-0:1.0: USB hub found
Apr 20 12:50:57 vostro kernel: [   94.482198] hub 5-0:1.0: 2 ports detected
Apr 20 12:50:57 vostro kernel: [   94.482265] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 12:50:57 vostro kernel: [   94.482268] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 6
Apr 20 12:50:57 vostro kernel: [   94.485004] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003
Apr 20 12:50:57 vostro kernel: [   94.485007] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 12:50:57 vostro kernel: [   94.485009] usb usb6: Product: xHCI Host Controller
Apr 20 12:50:57 vostro kernel: [   94.485011] usb usb6: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 12:50:57 vostro kernel: [   94.485013] usb usb6: SerialNumber: 0000:11:00.0
Apr 20 12:50:57 vostro kernel: [   94.485148] hub 6-0:1.0: USB hub found
Apr 20 12:50:57 vostro kernel: [   94.485167] hub 6-0:1.0: 2 ports detected
Apr 20 12:51:02 vostro kernel: [   98.754813] usb 5-1: new high-speed USB device number 2 using xhci_hcd
Apr 20 12:51:02 vostro kernel: [   98.778392] usb 5-1: New USB device found, idVendor=13fd, idProduct=0550
Apr 20 12:51:02 vostro kernel: [   98.778403] usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 20 12:51:02 vostro kernel: [   98.778409] usb 5-1: Product: ST9160821A      
Apr 20 12:51:02 vostro kernel: [   98.778415] usb 5-1: Manufacturer: Initio  
Apr 20 12:51:02 vostro kernel: [   98.778419] usb 5-1: SerialNumber: 00101005500011B80
Apr 20 12:51:02 vostro kernel: [   98.778626] usb 5-1: ep 0x81 - rounding interval to 32768 microframes, ep desc says 0 microframes
Apr 20 12:51:02 vostro kernel: [   98.778632] usb 5-1: ep 0x2 - rounding interval to 32768 microframes, ep desc says 0 microframes
Apr 20 12:51:02 vostro kernel: [   98.779399] scsi7 : usb-storage 5-1:1.0
Apr 20 12:51:02 vostro kernel: [   98.781416] generic-usb 0003:13FD:0550.0003: hiddev0,hidraw2: USB HID v1.10 Device [Initio   ST9160821A      ] on usb-0000:11:00.0-1/input1
Apr 20 12:51:03 vostro kernel: [   99.774241] scsi 7:0:0:0: Direct-Access     Initio   ST9160821A       3.12 PQ: 0 ANSI: 0
Apr 20 12:51:03 vostro kernel: [   99.774396] sd 7:0:0:0: Attached scsi generic sg3 type 0
Apr 20 12:51:03 vostro kernel: [   99.774615] sd 7:0:0:0: [sdc] 312581808 512-byte logical blocks: (160 GB/149 GiB)
Apr 20 12:51:03 vostro kernel: [   99.775241] sd 7:0:0:0: [sdc] Write Protect is off
Apr 20 12:51:03 vostro kernel: [   99.996721]  sdc: sdc1 sdc2
Apr 20 12:51:03 vostro kernel: [   99.998520] sd 7:0:0:0: [sdc] Attached SCSI disk

re-moved

Apr 20 12:51:45 vostro kernel: [  142.235281] pciehp 0000:00:1c.7:pcie04: lnk_status = 5011
Apr 20 12:51:45 vostro kernel: [  142.235286] pciehp 0000:00:1c.7:pcie04: Card not present on Slot(7)
Apr 20 12:51:45 vostro kernel: [  142.240178] xhci_hcd 0000:11:00.0: remove, state 4
Apr 20 12:51:45 vostro kernel: [  142.240185] usb usb6: USB disconnect, device number 1
Apr 20 12:51:45 vostro kernel: [  142.240323] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 12:51:45 vostro kernel: [  142.240326] xhci_hcd 0000:11:00.0: USB bus 6 deregistered
Apr 20 12:51:45 vostro kernel: [  142.240332] xhci_hcd 0000:11:00.0: remove, state 1
Apr 20 12:51:45 vostro kernel: [  142.240337] usb usb5: USB disconnect, device number 1
Apr 20 12:51:45 vostro kernel: [  142.240339] usb 5-1: USB disconnect, device number 2
Apr 20 12:52:35 vostro kernel: [  192.165855] xhci_hcd 0000:11:00.0: Timeout while waiting for configure endpoint command
Apr 20 12:52:35 vostro kernel: [  192.166142] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 12:52:35 vostro kernel: [  192.166242] xhci_hcd 0000:11:00.0: USB bus 5 deregistered

you see those "60s" delay above?

re-inserted

Apr 20 12:56:18 vostro kernel: [  414.651967] pciehp 0000:00:1c.7:pcie04: lnk_status = 7011
Apr 20 12:56:18 vostro kernel: [  414.651972] pciehp 0000:00:1c.7:pcie04: Card present on Slot(7)
Apr 20 12:56:18 vostro kernel: [  414.774447] pci 0000:11:00.0: BAR 0: assigned [mem 0xf6c00000-0xf6c01fff 64bit]
Apr 20 12:56:18 vostro kernel: [  414.774478] pcieport 0000:00:1c.7: PCI bridge to [bus 11-16]
Apr 20 12:56:18 vostro kernel: [  414.774493] pcieport 0000:00:1c.7:   bridge window [io  0xc000-0xdfff]
Apr 20 12:56:18 vostro kernel: [  414.774498] pcieport 0000:00:1c.7:   bridge window [mem 0xf6c00000-0xf7cfffff]
Apr 20 12:56:18 vostro kernel: [  414.774502] pcieport 0000:00:1c.7:   bridge window [mem 0xf0000000-0xf10fffff 64bit pref]
Apr 20 12:56:18 vostro kernel: [  414.774644] xhci_hcd 0000:11:00.0: enabling device (0100 -> 0102)
Apr 20 12:56:18 vostro kernel: [  414.774693] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 12:56:18 vostro kernel: [  414.774698] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 5
Apr 20 12:56:18 vostro kernel: [  414.774992] xhci_hcd 0000:11:00.0: irq 19, io mem 0xf6c00000
Apr 20 12:56:18 vostro kernel: [  414.775300] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
Apr 20 12:56:18 vostro kernel: [  414.775302] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 12:56:18 vostro kernel: [  414.775303] usb usb5: Product: xHCI Host Controller
Apr 20 12:56:18 vostro kernel: [  414.775304] usb usb5: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 12:56:18 vostro kernel: [  414.775305] usb usb5: SerialNumber: 0000:11:00.0
Apr 20 12:56:18 vostro kernel: [  414.775450] hub 5-0:1.0: USB hub found
Apr 20 12:56:18 vostro kernel: [  414.775462] hub 5-0:1.0: 2 ports detected
Apr 20 12:56:18 vostro kernel: [  414.775559] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 12:56:18 vostro kernel: [  414.775570] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 6
Apr 20 12:56:18 vostro kernel: [  414.778228] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003
Apr 20 12:56:18 vostro kernel: [  414.778230] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 12:56:18 vostro kernel: [  414.778231] usb usb6: Product: xHCI Host Controller
Apr 20 12:56:18 vostro kernel: [  414.778232] usb usb6: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 12:56:18 vostro kernel: [  414.778234] usb usb6: SerialNumber: 0000:11:00.0
Apr 20 12:56:18 vostro kernel: [  414.778320] hub 6-0:1.0: USB hub found
Apr 20 12:56:18 vostro kernel: [  414.778332] hub 6-0:1.0: 2 ports detected
Apr 20 12:56:18 vostro kernel: [  415.093937] usb 5-1: new high-speed USB device number 2 using xhci_hcd
Apr 20 12:56:18 vostro kernel: [  415.117398] usb 5-1: New USB device found, idVendor=13fd, idProduct=0550
Apr 20 12:56:18 vostro kernel: [  415.117409] usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 20 12:56:18 vostro kernel: [  415.117415] usb 5-1: Product: ST9160821A      
Apr 20 12:56:18 vostro kernel: [  415.117420] usb 5-1: Manufacturer: Initio  
Apr 20 12:56:18 vostro kernel: [  415.117425] usb 5-1: SerialNumber: 00101005500011B80
Apr 20 12:56:18 vostro kernel: [  415.117601] usb 5-1: ep 0x81 - rounding interval to 32768 microframes, ep desc says 0 microframes
Apr 20 12:56:18 vostro kernel: [  415.117606] usb 5-1: ep 0x2 - rounding interval to 32768 microframes, ep desc says 0 microframes
Apr 20 12:56:18 vostro kernel: [  415.118444] scsi8 : usb-storage 5-1:1.0
Apr 20 12:56:18 vostro kernel: [  415.120317] generic-usb 0003:13FD:0550.0004: hiddev0,hidraw2: USB HID v1.10 Device [Initio   ST9160821A      ] on usb-0000:11:00.0-1/input1
Apr 20 12:56:19 vostro kernel: [  416.113367] scsi 8:0:0:0: Direct-Access     Initio   ST9160821A       3.12 PQ: 0 ANSI: 0
Apr 20 12:56:19 vostro kernel: [  416.113528] sd 8:0:0:0: Attached scsi generic sg3 type 0
Apr 20 12:56:19 vostro kernel: [  416.113736] sd 8:0:0:0: [sdc] 312581808 512-byte logical blocks: (160 GB/149 GiB)
Apr 20 12:56:19 vostro kernel: [  416.114340] sd 8:0:0:0: [sdc] Write Protect is off
Apr 20 12:56:20 vostro kernel: [  416.309674]  sdc: sdc1 sdc2
Apr 20 12:56:20 vostro kernel: [  416.311327] sd 8:0:0:0: [sdc] Attached SCSI disk


removed

Apr 20 12:57:24 vostro kernel: [  481.131834] pciehp 0000:00:1c.7:pcie04: lnk_status = 5011
Apr 20 12:57:24 vostro kernel: [  481.131838] pciehp 0000:00:1c.7:pcie04: Card not present on Slot(7)
Apr 20 12:57:24 vostro kernel: [  481.135724] xhci_hcd 0000:11:00.0: remove, state 4
Apr 20 12:57:24 vostro kernel: [  481.135731] usb usb6: USB disconnect, device number 1
Apr 20 12:57:24 vostro kernel: [  481.135884] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 12:57:24 vostro kernel: [  481.135888] xhci_hcd 0000:11:00.0: USB bus 6 deregistered
Apr 20 12:57:24 vostro kernel: [  481.135893] xhci_hcd 0000:11:00.0: remove, state 1
Apr 20 12:57:24 vostro kernel: [  481.135898] usb usb5: USB disconnect, device number 1
Apr 20 12:57:24 vostro kernel: [  481.135900] usb 5-1: USB disconnect, device number 2
Apr 20 12:58:14 vostro kernel: [  531.061380] xhci_hcd 0000:11:00.0: Timeout while waiting for configure endpoint command
Apr 20 12:58:14 vostro kernel: [  531.061659] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 12:58:14 vostro kernel: [  531.061761] xhci_hcd 0000:11:00.0: USB bus 5 deregistered

you see those "60s" delay above?




Next tests without USB device attached to the express card:

re-inserting the card 

Apr 20 12:59:16 vostro kernel: [  592.704673] pciehp 0000:00:1c.7:pcie04: lnk_status = 7011
Apr 20 12:59:16 vostro kernel: [  592.704685] pciehp 0000:00:1c.7:pcie04: Card present on Slot(7)
Apr 20 12:59:16 vostro kernel: [  592.829402] pci 0000:11:00.0: BAR 0: assigned [mem 0xf6c00000-0xf6c01fff 64bit]
Apr 20 12:59:16 vostro kernel: [  592.829447] pcieport 0000:00:1c.7: PCI bridge to [bus 11-16]
Apr 20 12:59:16 vostro kernel: [  592.829450] pcieport 0000:00:1c.7:   bridge window [io  0xc000-0xdfff]
Apr 20 12:59:16 vostro kernel: [  592.829455] pcieport 0000:00:1c.7:   bridge window [mem 0xf6c00000-0xf7cfffff]
Apr 20 12:59:16 vostro kernel: [  592.829459] pcieport 0000:00:1c.7:   bridge window [mem 0xf0000000-0xf10fffff 64bit pref]
Apr 20 12:59:16 vostro kernel: [  592.829593] xhci_hcd 0000:11:00.0: enabling device (0100 -> 0102)
Apr 20 12:59:16 vostro kernel: [  592.829671] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 12:59:16 vostro kernel: [  592.829676] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 5
Apr 20 12:59:16 vostro kernel: [  592.829973] xhci_hcd 0000:11:00.0: irq 19, io mem 0xf6c00000
Apr 20 12:59:16 vostro kernel: [  592.830258] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
Apr 20 12:59:16 vostro kernel: [  592.830260] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 12:59:16 vostro kernel: [  592.830261] usb usb5: Product: xHCI Host Controller
Apr 20 12:59:16 vostro kernel: [  592.830262] usb usb5: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 12:59:16 vostro kernel: [  592.830263] usb usb5: SerialNumber: 0000:11:00.0
Apr 20 12:59:16 vostro kernel: [  592.830421] hub 5-0:1.0: USB hub found
Apr 20 12:59:16 vostro kernel: [  592.830434] hub 5-0:1.0: 2 ports detected
Apr 20 12:59:16 vostro kernel: [  592.830495] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 12:59:16 vostro kernel: [  592.830498] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 6
Apr 20 12:59:16 vostro kernel: [  592.833211] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003
Apr 20 12:59:16 vostro kernel: [  592.833214] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 12:59:16 vostro kernel: [  592.833216] usb usb6: Product: xHCI Host Controller
Apr 20 12:59:16 vostro kernel: [  592.833217] usb usb6: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 12:59:16 vostro kernel: [  592.833219] usb usb6: SerialNumber: 0000:11:00.0
Apr 20 12:59:16 vostro kernel: [  592.833345] hub 6-0:1.0: USB hub found
Apr 20 12:59:16 vostro kernel: [  592.833363] hub 6-0:1.0: 2 ports detected

re-moving the card

nothing happened

re-inserting the card

Apr 20 13:03:06 vostro kernel: [  725.782822] pciehp 0000:00:1c.7:pcie04: lnk_status = 5011
Apr 20 13:03:06 vostro kernel: [  725.782826] pciehp 0000:00:1c.7:pcie04: Card not present on Slot(7)
Apr 20 13:03:06 vostro kernel: [  725.791556] xhci_hcd 0000:11:00.0: remove, state 4
Apr 20 13:03:06 vostro kernel: [  725.791562] usb usb6: USB disconnect, device number 1
Apr 20 13:03:06 vostro kernel: [  725.791821] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 13:03:06 vostro kernel: [  725.791825] xhci_hcd 0000:11:00.0: USB bus 6 deregistered
Apr 20 13:03:06 vostro kernel: [  725.791830] xhci_hcd 0000:11:00.0: remove, state 4
Apr 20 13:03:06 vostro kernel: [  725.791834] usb usb5: USB disconnect, device number 1
Apr 20 13:03:06 vostro kernel: [  725.792107] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 13:03:06 vostro kernel: [  725.792188] xhci_hcd 0000:11:00.0: USB bus 5 deregistered
Apr 20 13:03:06 vostro kernel: [  725.799098] pciehp 0000:00:1c.7:pcie04: lnk_status = 7011
Apr 20 13:03:06 vostro kernel: [  725.799113] pciehp 0000:00:1c.7:pcie04: Card present on Slot(7)
Apr 20 13:03:06 vostro kernel: [  725.921259] pci 0000:11:00.0: BAR 0: assigned [mem 0xf6c00000-0xf6c01fff 64bit]
Apr 20 13:03:06 vostro kernel: [  725.921303] pcieport 0000:00:1c.7: PCI bridge to [bus 11-16]
Apr 20 13:03:06 vostro kernel: [  725.921306] pcieport 0000:00:1c.7:   bridge window [io  0xc000-0xdfff]
Apr 20 13:03:06 vostro kernel: [  725.921311] pcieport 0000:00:1c.7:   bridge window [mem 0xf6c00000-0xf7cfffff]
Apr 20 13:03:06 vostro kernel: [  725.921315] pcieport 0000:00:1c.7:   bridge window [mem 0xf0000000-0xf10fffff 64bit pref]
Apr 20 13:03:06 vostro kernel: [  725.921457] xhci_hcd 0000:11:00.0: enabling device (0100 -> 0102)
Apr 20 13:03:06 vostro kernel: [  725.921505] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 13:03:06 vostro kernel: [  725.921510] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 5
Apr 20 13:03:06 vostro kernel: [  725.921808] xhci_hcd 0000:11:00.0: irq 19, io mem 0xf6c00000
Apr 20 13:03:06 vostro kernel: [  725.922079] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
Apr 20 13:03:06 vostro kernel: [  725.922081] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 13:03:06 vostro kernel: [  725.922082] usb usb5: Product: xHCI Host Controller
Apr 20 13:03:06 vostro kernel: [  725.922083] usb usb5: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 13:03:06 vostro kernel: [  725.922084] usb usb5: SerialNumber: 0000:11:00.0
Apr 20 13:03:06 vostro kernel: [  725.922233] hub 5-0:1.0: USB hub found
Apr 20 13:03:06 vostro kernel: [  725.922244] hub 5-0:1.0: 2 ports detected
Apr 20 13:03:06 vostro kernel: [  725.922310] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 13:03:06 vostro kernel: [  725.922312] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 6
Apr 20 13:03:06 vostro kernel: [  725.925042] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003
Apr 20 13:03:06 vostro kernel: [  725.925045] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 13:03:06 vostro kernel: [  725.925047] usb usb6: Product: xHCI Host Controller
Apr 20 13:03:06 vostro kernel: [  725.925049] usb usb6: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 13:03:06 vostro kernel: [  725.925051] usb usb6: SerialNumber: 0000:11:00.0
Apr 20 13:03:06 vostro kernel: [  725.925203] hub 6-0:1.0: USB hub found
Apr 20 13:03:06 vostro kernel: [  725.925222] hub 6-0:1.0: 2 ports detected
     
removing the card

nothing happened

re-inserting the card

Apr 20 13:06:35 vostro kernel: [  935.028151] pciehp 0000:00:1c.7:pcie04: lnk_status = 5011
Apr 20 13:06:35 vostro kernel: [  935.028156] pciehp 0000:00:1c.7:pcie04: Card not present on Slot(7)
Apr 20 13:06:35 vostro kernel: [  935.030143] xhci_hcd 0000:11:00.0: remove, state 4
Apr 20 13:06:35 vostro kernel: [  935.030148] usb usb6: USB disconnect, device number 1
Apr 20 13:06:35 vostro kernel: [  935.030299] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 13:06:35 vostro kernel: [  935.030304] xhci_hcd 0000:11:00.0: USB bus 6 deregistered
Apr 20 13:06:35 vostro kernel: [  935.030310] xhci_hcd 0000:11:00.0: remove, state 4
Apr 20 13:06:35 vostro kernel: [  935.030315] usb usb5: USB disconnect, device number 1
Apr 20 13:06:35 vostro kernel: [  935.030410] xhci_hcd 0000:11:00.0: Host not halted after 16000 microseconds.
Apr 20 13:06:35 vostro kernel: [  935.030498] xhci_hcd 0000:11:00.0: USB bus 5 deregistered
Apr 20 13:06:35 vostro kernel: [  935.043622] pciehp 0000:00:1c.7:pcie04: lnk_status = 7011
Apr 20 13:06:35 vostro kernel: [  935.043627] pciehp 0000:00:1c.7:pcie04: Card present on Slot(7)
Apr 20 13:06:35 vostro kernel: [  935.169809] pci 0000:11:00.0: BAR 0: assigned [mem 0xf6c00000-0xf6c01fff 64bit]
Apr 20 13:06:35 vostro kernel: [  935.169842] pcieport 0000:00:1c.7: PCI bridge to [bus 11-16]
Apr 20 13:06:35 vostro kernel: [  935.169855] pcieport 0000:00:1c.7:   bridge window [io  0xc000-0xdfff]
Apr 20 13:06:35 vostro kernel: [  935.169860] pcieport 0000:00:1c.7:   bridge window [mem 0xf6c00000-0xf7cfffff]
Apr 20 13:06:35 vostro kernel: [  935.169864] pcieport 0000:00:1c.7:   bridge window [mem 0xf0000000-0xf10fffff 64bit pref]
Apr 20 13:06:35 vostro kernel: [  935.170001] xhci_hcd 0000:11:00.0: enabling device (0100 -> 0102)
Apr 20 13:06:35 vostro kernel: [  935.170054] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 13:06:35 vostro kernel: [  935.170059] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 5
Apr 20 13:06:35 vostro kernel: [  935.170349] xhci_hcd 0000:11:00.0: irq 19, io mem 0xf6c00000
Apr 20 13:06:35 vostro kernel: [  935.170652] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
Apr 20 13:06:35 vostro kernel: [  935.170654] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 13:06:35 vostro kernel: [  935.170656] usb usb5: Product: xHCI Host Controller
Apr 20 13:06:35 vostro kernel: [  935.170657] usb usb5: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 13:06:35 vostro kernel: [  935.170658] usb usb5: SerialNumber: 0000:11:00.0
Apr 20 13:06:35 vostro kernel: [  935.170742] hub 5-0:1.0: USB hub found
Apr 20 13:06:35 vostro kernel: [  935.170753] hub 5-0:1.0: 2 ports detected
Apr 20 13:06:35 vostro kernel: [  935.170855] xhci_hcd 0000:11:00.0: xHCI Host Controller
Apr 20 13:06:35 vostro kernel: [  935.170860] xhci_hcd 0000:11:00.0: new USB bus registered, assigned bus number 6
Apr 20 13:06:35 vostro kernel: [  935.173587] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003
Apr 20 13:06:35 vostro kernel: [  935.173589] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 20 13:06:35 vostro kernel: [  935.173591] usb usb6: Product: xHCI Host Controller
Apr 20 13:06:35 vostro kernel: [  935.173592] usb usb6: Manufacturer: Linux 3.4.0-rc3-default xhci_hcd
Apr 20 13:06:35 vostro kernel: [  935.173593] usb usb6: SerialNumber: 0000:11:00.0
Apr 20 13:06:35 vostro kernel: [  935.173678] hub 6-0:1.0: USB hub found
Apr 20 13:06:35 vostro kernel: [  935.173689] hub 6-0:1.0: 2 ports detected

re-moving the card


Complete dmesg is attached. OK, the "60sec" delay is when xhci_hcd gives away its attempts.
I am not knowlegeable of the kernel at all but it is my impression that because of the
card presence detection there is no way to prevent that. But, if I get it right, now when I
pluging the card+USB disk in it into the computer before those "60sec" it gets detected,
so my problem is gone (xhci cancels the timeout because a "new card" was popped in with a "new"
device.

So, although I am now not sure whether I need your last patch, for the practical purpose that
I want to plugin a new card with a device into my computer, it works now. (added Sarah Sharp
into CC: just to make her aware of this scenario, no problem with xhci_hcd in my eyes)
;)

Martin

View attachment "dmesg.txt" of type "text/plain" (86880 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ