On Fri, Oct 14, 2016 at 06:53:29PM +0500, Михаил Гаврилов wrote:
> [ 16.685607] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 16.893766] usb 2-5.4: Device not responding to setup address.
> [ 17.098457] usb 2-5.4: device not accepting address 6, error -71
> [ 17.162458] usb 1-9.1.6: new full-speed USB device number 8 using xhci_hcd
> [ 17.242470] usb 1-9.1.6: New USB device found, idVendor=046d, idProduct=c52b
> [ 17.242476] usb 1-9.1.6: New USB device strings: Mfr=1, Product=2, SerialNumber=0
> [ 17.242479] usb 1-9.1.6: Product: USB Receiver
> [ 17.242482] usb 1-9.1.6: Manufacturer: Logitech
Hm, not good.
<snip>
> [ 30.678097] usb 2-5.4: Device not responding to setup address.
> [ 30.882771] usb 2-5.4: device not accepting address 7, error -71
> [ 30.950961] usb 1-9.1.2: reset high-speed USB device number 5 using xhci_hcd
> [ 31.096011] option 1-9.1.2:1.0: GSM modem (1-port) converter detected
> [ 31.096269] usb 1-9.1.2: GSM modem (1-port) converter now attached to ttyUSB0
> [ 31.096304] option 1-9.1.2:1.1: GSM modem (1-port) converter detected
> [ 31.096474] usb 1-9.1.2: GSM modem (1-port) converter now attached to ttyUSB1
Also odd...
> [ 86.385506] usb 2-5.4: Device not responding to setup address.
> [ 86.590238] usb 2-5.4: device not accepting address 12, error -71
> [ 86.590798] usb 2-5-port4: unable to enumerate USB device
> [ 101.516693] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 101.722125] usb 2-5.4: Device not responding to setup address.
> [ 101.926702] usb 2-5.4: device not accepting address 16, error -71
> [ 115.338361] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 115.546467] usb 2-5.4: Device not responding to setup address.
> [ 115.751170] usb 2-5.4: device not accepting address 17, error -71
> [ 129.185004] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 129.397080] usb 2-5.4: Device not responding to setup address.
> [ 129.601697] usb 2-5.4: device not accepting address 18, error -71
> [ 143.024578] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 143.231669] usb 2-5.4: Device not responding to setup address.
> [ 143.436203] usb 2-5.4: device not accepting address 19, error -71
> [ 143.436814] usb 2-5-port4: unable to enumerate USB device
> [ 157.882154] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 158.090299] usb 2-5.4: Device not responding to setup address.
> [ 158.294896] usb 2-5.4: device not accepting address 22, error -71
> [ 171.710696] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 171.916643] usb 2-5.4: Device not responding to setup address.
> [ 172.121397] usb 2-5.4: device not accepting address 23, error -71
> [ 185.542558] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 185.751236] usb 2-5.4: Device not responding to setup address.
> [ 185.955910] usb 2-5.4: device not accepting address 24, error -71
> [ 199.376149] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 199.585824] usb 2-5.4: Device not responding to setup address.
> [ 199.790405] usb 2-5.4: device not accepting address 25, error -71
> [ 199.790982] usb 2-5-port4: unable to enumerate USB device
> [ 215.279864] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 215.484730] usb 2-5.4: Device not responding to setup address.
> [ 215.689305] usb 2-5.4: device not accepting address 30, error -71
> [ 229.092273] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 229.303070] usb 2-5.4: Device not responding to setup address.
> [ 229.507787] usb 2-5.4: device not accepting address 31, error -71
> [ 243.006432] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 243.217684] usb 2-5.4: Device not responding to setup address.
> [ 243.422307] usb 2-5.4: device not accepting address 32, error -71
> [ 256.887746] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 257.100277] usb 2-5.4: Device not responding to setup address.
> [ 257.304830] usb 2-5.4: device not accepting address 33, error -71
> [ 257.305437] usb 2-5-port4: unable to enumerate USB device
> [ 272.222579] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 272.430894] usb 2-5.4: Device not responding to setup address.
> [ 272.635589] usb 2-5.4: device not accepting address 37, error -71
> [ 286.017843] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 286.225508] usb 2-5.4: Device not responding to setup address.
> [ 286.430078] usb 2-5.4: device not accepting address 38, error -71
> [ 299.838156] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 300.044133] usb 2-5.4: Device not responding to setup address.
> [ 300.248612] usb 2-5.4: device not accepting address 39, error -71
> [ 313.811194] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 314.022447] usb 2-5.4: Device not responding to setup address.
> [ 314.227177] usb 2-5.4: device not accepting address 40, error -71
> [ 314.227820] usb 2-5-port4: unable to enumerate USB device
> [ 328.123583] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 328.332796] usb 2-5.4: Device not responding to setup address.
> [ 328.537420] usb 2-5.4: device not accepting address 41, error -71
> [ 342.508237] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 342.717150] usb 2-5.4: Device not responding to setup address.
> [ 342.921824] usb 2-5.4: device not accepting address 42, error -71
> [ 356.761656] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 356.973771] usb 2-5.4: Device not responding to setup address.
> [ 357.178298] usb 2-5.4: device not accepting address 43, error -71
And now things are not good at all, but we are locked up:
> [ 369.658729] INFO: task pool:2352 blocked for more than 120 seconds.
> [ 369.658733] Not tainted 4.8.1-1.fc25.x86_64+debug #1
> [ 369.658735] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
> [ 369.658736] pool D ffff9eb39050b768 11816 2352 1613 0x00000000
> [ 369.658751] ffff9eb39050b768 0000000000000000 0000000000000000 ffff9eb3ff1da3c0
> [ 369.658754] ffff9eb3fb360000 ffff9eb3794e8000 ffff9eb39050c000 ffff9eb375e081d8
> [ 369.658756] ffff9eb375e081d0 ffff9eb3794e8000 ffffffff9a8f11b6 ffff9eb39050b780
> [ 369.658759] Call Trace:
> [ 369.658764] [<ffffffff9a8f11b6>] ? wait_for_completion+0xe6/0x140
> [ 369.658765] [<ffffffff9a8efb8c>] schedule+0x3c/0x90
> [ 369.658766] [<ffffffff9a8f51ea>] schedule_timeout+0x35a/0x590
> [ 369.658769] [<ffffffff9a0ea487>] ? sched_clock_cpu+0xa7/0xc0
> [ 369.658771] [<ffffffff9a10e216>] ? mark_held_locks+0x76/0xa0
> [ 369.658772] [<ffffffff9a8f626c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [ 369.658773] [<ffffffff9a8f11b6>] ? wait_for_completion+0xe6/0x140
> [ 369.658774] [<ffffffff9a10e335>] ? trace_hardirqs_on_caller+0xf5/0x1b0
> [ 369.658776] [<ffffffff9a8f11b6>] ? wait_for_completion+0xe6/0x140
> [ 369.658777] [<ffffffff9a8f11d4>] wait_for_completion+0x104/0x140
> [ 369.658778] [<ffffffff9a0e37f0>] ? wake_up_q+0x80/0x80
> [ 369.658809] [<ffffffffc0c49803>] ? _xfs_buf_read+0x73/0x90 [xfs]
> [ 369.658827] [<ffffffffc0c49421>] xfs_buf_submit_wait+0xd1/0x440 [xfs]
> [ 369.658843] [<ffffffffc0c49803>] _xfs_buf_read+0x73/0x90 [xfs]
> [ 369.658859] [<ffffffffc0c498fe>] xfs_buf_read_map+0xde/0x300 [xfs]
> [ 369.658878] [<ffffffffc0c87317>] ? xfs_trans_read_buf_map+0x1d7/0x650 [xfs]
> [ 369.658897] [<ffffffffc0c87317>] xfs_trans_read_buf_map+0x1d7/0x650 [xfs]
> [ 369.658913] [<ffffffffc0c34031>] xfs_imap_to_bp+0x71/0x110 [xfs]
> [ 369.658929] [<ffffffffc0c347f7>] xfs_iread+0x87/0x2f0 [xfs]
> [ 369.658946] [<ffffffffc0c55945>] xfs_iget+0x595/0x1070 [xfs]
> [ 369.658962] [<ffffffffc0c5558b>] ? xfs_iget+0x1db/0x1070 [xfs]
> [ 369.658979] [<ffffffffc0c61d80>] xfs_lookup+0x140/0x200 [xfs]
> [ 369.658996] [<ffffffffc0c5ce13>] xfs_vn_lookup+0x73/0xb0 [xfs]
> [ 369.658998] [<ffffffff9a2adc52>] lookup_slow+0x132/0x220
> [ 369.659000] [<ffffffff9a2b1aac>] walk_component+0x1ec/0x310
> [ 369.659002] [<ffffffff9a2b1494>] ? path_init+0x644/0x750
> [ 369.659004] [<ffffffff9a2b22f7>] path_lookupat+0x67/0x120
> [ 369.659005] [<ffffffff9a2b37d1>] filename_lookup+0xb1/0x180
> [ 369.659007] [<ffffffff9a12e175>] ? rcu_read_lock_sched_held+0x45/0x80
> [ 369.659008] [<ffffffff9a26f54a>] ? kmem_cache_alloc+0x27a/0x2d0
> [ 369.659009] [<ffffffff9a2b33cf>] ? getname_flags+0x4f/0x1f0
> [ 369.659011] [<ffffffff9a2b3976>] user_path_at_empty+0x36/0x40
> [ 369.659012] [<ffffffff9a2a7136>] vfs_fstatat+0x66/0xc0
> [ 369.659013] [<ffffffff9a10e335>] ? trace_hardirqs_on_caller+0xf5/0x1b0
> [ 369.659015] [<ffffffff9a2a7731>] SYSC_newlstat+0x31/0x60
> [ 369.659016] [<ffffffff9a10e335>] ? trace_hardirqs_on_caller+0xf5/0x1b0
> [ 369.659018] [<ffffffff9a00301a>] ? trace_hardirqs_on_thunk+0x1a/0x1c
> [ 369.659019] [<ffffffff9a2a786e>] SyS_newlstat+0xe/0x10
> [ 369.659021] [<ffffffff9a8f6b3c>] entry_SYSCALL_64_fastpath+0x1f/0xbd
> [ 369.659022] 2 locks held by pool/2352:
> [ 369.659023] #0: (&type->i_mutex_dir_key#4){++++++}, at: [<ffffffff9a2adc05>] lookup_slow+0xe5/0x220
> [ 369.659028] #1: (&(&ip->i_iolock)->mr_lock){++++++}, at: [<ffffffffc0c60291>] xfs_ilock+0x231/0x2c0 [xfs]
> [ 370.634239] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
xfs having issues?
> [ 370.846125] usb 2-5.4: Device not responding to setup address.
> [ 371.050715] usb 2-5.4: device not accepting address 44, error -71
> [ 371.051399] usb 2-5-port4: unable to enumerate USB device
> [ 385.440658] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 385.646496] usb 2-5.4: Device not responding to setup address.
> [ 385.851167] usb 2-5.4: device not accepting address 46, error -71
> [ 391.163312] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
> [ 422.908305] xhci_hcd 0000:00:14.0: xHCI host not responding to stop endpoint command.
> [ 422.908307] xhci_hcd 0000:00:14.0: Assuming host is dying, halting host.
There, your host controller was disabled, something is really wrong with
it, that's why replugging doesn't help.
Did this work successfully on older kernels? If so, any chance you can
use 'git bisect' to find the issue?
thanks,
greg k-h
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
