Bug 1376579 - Not enough host controller resources for new device state
Summary: Not enough host controller resources for new device state
Keywords:
Status: CLOSED INSUFFICIENT_DATA
Alias: None
Product: Fedora
Classification: Fedora
Component: kernel
Version: 24
Hardware: x86_64
OS: Linux
unspecified
high
Target Milestone: ---
Assignee: Kernel Maintainer List
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2016-09-15 19:09 UTC by Wolfgang Denk
Modified: 2018-03-11 17:12 UTC (History)
8 users (show)

Fixed In Version:
Doc Type: If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed: 2017-04-28 17:18:09 UTC
Type: Bug
Embargoed:


Attachments (Terms of Use)

Description Wolfgang Denk 2016-09-15 19:09:57 UTC
Description of problem:

Hardware: Supermicro X8SAX mainboard with Xeon CPU W3565 @ 3.20GHz

USB 3.0 controller on PCI: ASMedia Technology Inc. ASM1042 SuperSpeed USB Host Controller

Logilink USB3.0 7-port hub

The USB3.0 hub is plugged into the USB 3.0 PCI controller card;
when plugging in a USB 3.0 mass storage device into the hub, the
following error is printed:

Not enough host controller resources for new device state.

The mass storage device cannot be accessed.


Version-Release number of selected component (if applicable):

kernel-4.7.3-200.fc24.x86_64

(same with kernel-4.6.6-300.fc24.x86_64, kernel-4.6.5-300.fc24.x86_64
and older kernel versions)

How reproducible:

Always

Steps to Reproduce:
1. Boot up Linux
2. Plug in USB 3.0 hub into PCI USB 3.0 controller card
3. Plug in USB 3.0 mass storage device into USB 3.0

Actual results:

Error: Not enough host controller resources for new device state.
The mass storage device cannot be accessed.

Expected results:

No errors.  The mass storage device can be used.

Additional info:

It appears similar errors have been reported many times before, but
they all talk about having many USB devices attached.  Here, this is
not the case:

# lsusb -t
/:  Bus 10.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/2p, 5000M
    |__ Port 2: Dev 8, If 0, Class=Hub, Driver=hub/4p, 5000M
        |__ Port 1: Dev 9, If 0, Class=Hub, Driver=hub/4p, 5000M
        |__ Port 4: Dev 10, If 0, Class=Mass Storage, Driver=usb-storage, 5000M
/:  Bus 09.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/2p, 480M
    |__ Port 2: Dev 4, If 0, Class=Hub, Driver=hub/4p, 480M
        |__ Port 1: Dev 5, If 0, Class=Hub, Driver=hub/4p, 480M
/:  Bus 08.Port 1: Dev 1, Class=root_hub, Driver=uhci_hcd/2p, 12M
/:  Bus 07.Port 1: Dev 1, Class=root_hub, Driver=uhci_hcd/2p, 12M
/:  Bus 06.Port 1: Dev 1, Class=root_hub, Driver=uhci_hcd/2p, 12M
/:  Bus 05.Port 1: Dev 1, Class=root_hub, Driver=uhci_hcd/2p, 12M
    |__ Port 1: Dev 2, If 0, Class=Human Interface Device, Driver=usbhid, 12M
    |__ Port 1: Dev 2, If 1, Class=Human Interface Device, Driver=usbhid, 12M
/:  Bus 04.Port 1: Dev 1, Class=root_hub, Driver=uhci_hcd/2p, 12M
/:  Bus 03.Port 1: Dev 1, Class=root_hub, Driver=uhci_hcd/2p, 12M
/:  Bus 02.Port 1: Dev 1, Class=root_hub, Driver=ehci-pci/6p, 480M
    |__ Port 4: Dev 2, If 0, Class=Mass Storage, Driver=usb-storage, 480M
/:  Bus 01.Port 1: Dev 1, Class=root_hub, Driver=ehci-pci/6p, 480M

Also, the behaviour actually depends on how the USB devices get attached:

Test 1:  Plug USB hub into PC, then plug USB MSD into USB hub

Part a) Plug USB hub into PC

Sep 15 20:43:36 atlas.denx.de kernel: usb 10-2: new SuperSpeed USB device number 2 using xhci_hcd
Sep 15 20:43:36 atlas.denx.de kernel: usb 10-2: New USB device found, idVendor=05e3, idProduct=0612
Sep 15 20:43:36 atlas.denx.de kernel: usb 10-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:43:36 atlas.denx.de kernel: usb 10-2: Product: USB3.0 Hub
Sep 15 20:43:36 atlas.denx.de kernel: usb 10-2: Manufacturer: GenesysLogic
Sep 15 20:43:36 atlas.denx.de kernel: hub 10-2:1.0: USB hub found
Sep 15 20:43:36 atlas.denx.de kernel: hub 10-2:1.0: 4 ports detected
Sep 15 20:43:36 atlas.denx.de kernel: usb 9-2: new high-speed USB device number 2 using xhci_hcd
Sep 15 20:43:36 atlas.denx.de kernel: usb 9-2: New USB device found, idVendor=05e3, idProduct=0610
Sep 15 20:43:36 atlas.denx.de kernel: usb 9-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:43:36 atlas.denx.de kernel: usb 9-2: Product: USB2.0 Hub
Sep 15 20:43:36 atlas.denx.de kernel: usb 9-2: Manufacturer: GenesysLogic
Sep 15 20:43:36 atlas.denx.de kernel: hub 9-2:1.0: USB hub found
Sep 15 20:43:36 atlas.denx.de kernel: hub 9-2:1.0: 4 ports detected
Sep 15 20:43:37 atlas.denx.de kernel: usb 10-2.1: new SuperSpeed USB device number 3 using xhci_hcd
Sep 15 20:43:37 atlas.denx.de kernel: usb 10-2.1: New USB device found, idVendor=05e3, idProduct=0612
Sep 15 20:43:37 atlas.denx.de kernel: usb 10-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:43:37 atlas.denx.de kernel: usb 10-2.1: Product: USB3.0 Hub
Sep 15 20:43:37 atlas.denx.de kernel: usb 10-2.1: Manufacturer: GenesysLogic
Sep 15 20:43:37 atlas.denx.de kernel: hub 10-2.1:1.0: USB hub found
Sep 15 20:43:37 atlas.denx.de kernel: hub 10-2.1:1.0: 4 ports detected
Sep 15 20:43:37 atlas.denx.de systemd-udevd[6067]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:43:37 atlas.denx.de systemd-udevd[6070]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:43:37 atlas.denx.de systemd-udevd[6067]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:43:37 atlas.denx.de kernel: usb 9-2.1: new high-speed USB device number 3 using xhci_hcd
Sep 15 20:43:37 atlas.denx.de kernel: usb 9-2.1: New USB device found, idVendor=05e3, idProduct=0610
Sep 15 20:43:37 atlas.denx.de kernel: usb 9-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:43:37 atlas.denx.de kernel: usb 9-2.1: Product: USB2.0 Hub
Sep 15 20:43:37 atlas.denx.de kernel: usb 9-2.1: Manufacturer: GenesysLogic
Sep 15 20:43:37 atlas.denx.de kernel: hub 9-2.1:1.0: USB hub found
Sep 15 20:43:37 atlas.denx.de kernel: hub 9-2.1:1.0: 4 ports detected
Sep 15 20:43:37 atlas.denx.de systemd-udevd[6103]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.

Part b) Plug USB MSD into USB hub


Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: new SuperSpeed USB device number 4 using xhci_hcd
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: New USB device found, idVendor=2537, idProduct=1066
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: Product: NS1066
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: Manufacturer: Norelsys
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: SerialNumber: 0123456789ABCDE
Sep 15 20:43:58 atlas.denx.de kernel: usb-storage 10-2.4:1.0: USB Mass Storage device detected
Sep 15 20:43:58 atlas.denx.de kernel: scsi host15: usb-storage 10-2.4:1.0
Sep 15 20:43:58 atlas.denx.de mtp-probe[6121]: checking bus 10, device 4: "/sys/devices/pci0000:00/0000:00:1c.0/0000:05:00.0/usb10/10-2/10-2.4"
Sep 15 20:43:58 atlas.denx.de mtp-probe[6121]: bus: 10, device: 4 was not an MTP device
Sep 15 20:43:58 atlas.denx.de systemd-udevd[6115]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.1: USB disconnect, device number 3
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2.4: USB disconnect, device number 4
Sep 15 20:43:58 atlas.denx.de kernel: usb 10-2: reset SuperSpeed USB device number 2 using xhci_hcd
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: new SuperSpeed USB device number 5 using xhci_hcd
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: New USB device found, idVendor=05e3, idProduct=0612
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: Product: USB3.0 Hub
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: Manufacturer: GenesysLogic
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: Not enough host controller resources for new device state.
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.1: can't set config #1, error -12
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: new SuperSpeed USB device number 6 using xhci_hcd
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: New USB device found, idVendor=2537, idProduct=1066
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: Product: NS1066
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: Manufacturer: Norelsys
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: SerialNumber: 0123456789ABCDE
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: Not enough host controller resources for new device state.
Sep 15 20:43:59 atlas.denx.de kernel: usb 10-2.4: can't set config #1, error -12
Sep 15 20:43:59 atlas.denx.de mtp-probe[6157]: checking bus 10, device 6: "/sys/devices/pci0000:00/0000:00:1c.0/0000:05:00.0/usb10/10-2/10-2.4"
Sep 15 20:43:59 atlas.denx.de mtp-probe[6157]: bus: 10, device: 6 was not an MTP device

==> Mass Storage Device not attached, cannot be accessed.


Test 2:  Plug USB MSD into USB hub, then plug USB hub with MSD already attached into PC

Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2: new SuperSpeed USB device number 8 using xhci_hcd
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2: New USB device found, idVendor=05e3, idProduct=0612
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2: Product: USB3.0 Hub
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2: Manufacturer: GenesysLogic
Sep 15 20:47:36 atlas.denx.de kernel: hub 10-2:1.0: USB hub found
Sep 15 20:47:36 atlas.denx.de kernel: hub 10-2:1.0: 4 ports detected
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2: new high-speed USB device number 4 using xhci_hcd
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2: New USB device found, idVendor=05e3, idProduct=0610
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2: Product: USB2.0 Hub
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2: Manufacturer: GenesysLogic
Sep 15 20:47:36 atlas.denx.de kernel: hub 9-2:1.0: USB hub found
Sep 15 20:47:36 atlas.denx.de kernel: hub 9-2:1.0: 4 ports detected
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.1: new SuperSpeed USB device number 9 using xhci_hcd
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.1: New USB device found, idVendor=05e3, idProduct=0612
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.1: Product: USB3.0 Hub
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.1: Manufacturer: GenesysLogic
Sep 15 20:47:36 atlas.denx.de kernel: hub 10-2.1:1.0: USB hub found
Sep 15 20:47:36 atlas.denx.de kernel: hub 10-2.1:1.0: 4 ports detected
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.4: new SuperSpeed USB device number 10 using xhci_hcd
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.4: New USB device found, idVendor=2537, idProduct=1066
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.4: Product: NS1066
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.4: Manufacturer: Norelsys
Sep 15 20:47:36 atlas.denx.de kernel: usb 10-2.4: SerialNumber: 0123456789ABCDE
Sep 15 20:47:36 atlas.denx.de kernel: usb-storage 10-2.4:1.0: USB Mass Storage device detected
Sep 15 20:47:36 atlas.denx.de kernel: scsi host15: usb-storage 10-2.4:1.0
Sep 15 20:47:36 atlas.denx.de systemd-udevd[6344]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2.1: new high-speed USB device number 5 using xhci_hcd
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2.1: New USB device found, idVendor=05e3, idProduct=0610
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2.1: Product: USB2.0 Hub
Sep 15 20:47:36 atlas.denx.de kernel: usb 9-2.1: Manufacturer: GenesysLogic
Sep 15 20:47:36 atlas.denx.de kernel: hub 9-2.1:1.0: USB hub found
Sep 15 20:47:36 atlas.denx.de kernel: hub 9-2.1:1.0: 4 ports detected
Sep 15 20:47:36 atlas.denx.de systemd-udevd[6347]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:47:36 atlas.denx.de mtp-probe[6377]: checking bus 10, device 10: "/sys/devices/pci0000:00/0000:00:1c.0/0000:05:00.0/usb10/10-2/10-2.4"
Sep 15 20:47:36 atlas.denx.de mtp-probe[6377]: bus: 10, device: 10 was not an MTP device
Sep 15 20:47:36 atlas.denx.de systemd-udevd[6367]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:47:36 atlas.denx.de systemd-udevd[6368]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:47:36 atlas.denx.de systemd-udevd[6344]: Process '/usr/bin/setfacl -m g:lirc:rw ' failed with exit code 2.
Sep 15 20:47:39 atlas.denx.de kernel: scsi 15:0:0:0: Direct-Access     ATA      Samsung SSD 850  2B6Q PQ: 0 ANSI: 6
Sep 15 20:47:39 atlas.denx.de kernel: sd 15:0:0:0: Attached scsi generic sg13 type 0
Sep 15 20:47:39 atlas.denx.de kernel: sd 15:0:0:0: [sdn] 488397168 512-byte logical blocks: (250 GB/233 GiB)
Sep 15 20:47:39 atlas.denx.de kernel: sd 15:0:0:0: [sdn] Write Protect is off
Sep 15 20:47:39 atlas.denx.de kernel: sd 15:0:0:0: [sdn] Mode Sense: 43 00 00 00
Sep 15 20:47:39 atlas.denx.de kernel: sd 15:0:0:0: [sdn] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Sep 15 20:47:39 atlas.denx.de kernel:  sdn: sdn1
Sep 15 20:47:39 atlas.denx.de kernel: sd 15:0:0:0: [sdn] Attached SCSI disk

==> Mass Storage Device gets attached and can be used.

So if the number of devices was a problem, it should not work in
either case; instead, it reliably works fine when I plug in the hub
with all devices pre-attached, and it reliably fails when I try to
attach devices to the hub one by one after the hub was already
connected to the PC.

There is no difference in behaviour whether the USB hub is externally
powered or not.

The same behaviour is observed using a different type of USB 3.0 hub
(goobay).

Comment 1 Justin M. Forbes 2017-04-11 14:45:22 UTC
*********** MASS BUG UPDATE **************

We apologize for the inconvenience.  There are a large number of bugs to go through and several of them have gone stale.  Due to this, we are doing a mass bug update across all of the Fedora 24 kernel bugs.

Fedora 25 has now been rebased to 4.10.9-100.fc24.  Please test this kernel update (or newer) and let us know if you issue has been resolved or if it is still present with the newer kernel.

If you have moved on to Fedora 26, and are still experiencing this issue, please change the version to Fedora 26.

If you experience different issues, please open a new bug report for those.

Comment 2 Justin M. Forbes 2017-04-28 17:18:09 UTC
*********** MASS BUG UPDATE **************
This bug is being closed with INSUFFICIENT_DATA as there has not been a response in 2 weeks. If you are still experiencing this issue, please reopen and attach the 
relevant data from the latest kernel you are running and any data that might have been requested previously.

Comment 3 Pekka Järveläinen 2018-03-11 17:12:46 UTC
  387.643710] usb 4-5.1: new SuperSpeed USB device number 15 using xhci_hcd
[  387.656254] usb 4-5.1: New USB device found, idVendor=1f75, idProduct=0916
[  387.656262] usb 4-5.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  387.656267] usb 4-5.1: Product: USB DISK
[  387.656271] usb 4-5.1: Manufacturer:  
[  387.656276] usb 4-5.1: SerialNumber: 14051501000510
[  387.660018] usb 4-5.1: Not enough host controller resources for new device state.
[  387.660060] usb 4-5.1: can't set config #1, error -12

Fedora 27 with quite new kernel
uname -a
Linux localhost.home 4.15.4-300.fc27.x86_64 #1 SMP Mon Feb 19 23:31:15 UTC 2018 x86_64 x86_64 x86_64 GNU/Linux

I have 7 port TP-link UDB-hub (in full use) but for this USB-stick I used 4-port Orico hub. I have 3 other hubs. Totally 18 ports which 15 in use. I already have disks to /dev/sdf. 

The connecting the same disk succeeded immediately after removing one old one:
1548.425353] sdf: detected capacity change from 126298882048 to 0
[ 1551.601614] usb 4-5.2: USB disconnect, device number 14
[ 1557.105553] usb 4-5.1: USB disconnect, device number 15
[ 1562.646498] usb 4-5.2: new SuperSpeed USB device number 16 using xhci_hcd
[ 1562.658936] usb 4-5.2: New USB device found, idVendor=1f75, idProduct=0916
[ 1562.658939] usb 4-5.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 1562.658940] usb 4-5.2: Product: USB DISK
[ 1562.658942] usb 4-5.2: Manufacturer:  
[ 1562.658943] usb 4-5.2: SerialNumber: 14051501000510
[ 1562.660650] usb-storage 4-5.2:1.0: USB Mass Storage device detected
[ 1562.660852] scsi host10: usb-storage 4-5.2:1.0
[ 1563.670795] scsi 10:0:0:0: Direct-Access                               1.00 PQ: 0 ANSI: 6
[ 1563.671347] sd 10:0:0:0: [sdf] 61440000 512-byte logical blocks: (31.5 GB/29.3 GiB)
[ 1563.671430] sd 10:0:0:0: Attached scsi generic sg6 type 0
[ 1563.671546] sd 10:0:0:0: [sdf] Write Protect is off
[ 1563.671553] sd 10:0:0:0: [sdf] Mode Sense: 03 00 00 00

Would you please add maximum number of USB-disks. 
[


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