All of lore.kernel.org
 help / color / mirror / Atom feed
* [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds.
@ 2014-06-10 16:50 bugzilla-daemon
       [not found] ` <bug-77631-11613-3bo0kxnWaOQUvHkbgXJLS5sdmw4N0Rt+2LY78lusg7I@public.gmane.org/>
                   ` (4 more replies)
  0 siblings, 5 replies; 7+ messages in thread
From: bugzilla-daemon @ 2014-06-10 16:50 UTC (permalink / raw)
  To: linux-scsi

https://bugzilla.kernel.org/show_bug.cgi?id=77631

            Bug ID: 77631
           Summary: task scsi_eh_6:537 blocked for more than 120 seconds.
           Product: IO/Storage
           Version: 2.5
    Kernel Version: 3.14.6
          Hardware: All
                OS: Linux
              Tree: Mainline
            Status: NEW
          Severity: normal
          Priority: P1
         Component: SCSI
          Assignee: linux-scsi@vger.kernel.org
          Reporter: mikhail.v.gavrilov@gmail.com
        Regression: No

Created attachment 138941
  --> https://bugzilla.kernel.org/attachment.cgi?id=138941&action=edit
kernel log

task scsi_eh_6:537 blocked for more than 120 seconds.


[  240.036323] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
[  240.036333]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  240.036337] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  240.036341] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
[  240.036355]  ffff8808027cdc50 0000000000000046 ffff88007c988000
ffff8808027cdfd8
[  240.036366]  00000000001d5800 00000000001d5800 ffff88007c988000
ffff880810ca6bf0
[  240.036375]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
ffff88080c532600
[  240.036384] Call Trace:
[  240.036400]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
[  240.036409]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
[  240.036434]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  240.036450]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  240.036466]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
[  240.036478]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
[  240.036487]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
[  240.036495]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
[  240.036504]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
[  240.036512]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
[  240.036522]  [<ffffffff810c452f>] kthread+0xff/0x120
[  240.036530]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  240.036540]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  240.036547]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  240.036553] 1 lock held by scsi_eh_6/537:
[  240.036555]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
device_reset+0x24/0x50 [usb_storage]
[  240.036575] INFO: task usb-storage:539 blocked for more than 120 seconds.
[  240.036579]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  240.036582] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  240.036585] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
[  240.036595]  ffff8808025ebae0 0000000000000046 ffff880800c28000
ffff8808025ebfd8
[  240.036604]  00000000001d5800 00000000001d5800 ffff880800c28000
7fffffffffffffff
[  240.036612]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
0000000000000000
[  240.036621] Call Trace:
[  240.036629]  [<ffffffff817daad9>] schedule+0x29/0x70
[  240.036637]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
[  240.036648]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  240.036657]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  240.036665]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
[  240.036673]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
[  240.036684]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
[  240.036692]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
[  240.036709]  [<ffffffffa035e4db>]
usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
[  240.036725]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
[  240.036741]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
[usb_storage]
[  240.036758]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
[usb_storage]
[  240.036766]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  240.036774]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  240.036790]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
[usb_storage]
[  240.036807]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
[usb_storage]
[  240.036824]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  240.036840]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  240.036847]  [<ffffffff810c452f>] kthread+0xff/0x120
[  240.036854]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  240.036862]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  240.036869]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  240.036873] 1 lock held by usb-storage/539:
[  240.036876]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
usb_stor_control_thread+0x8a/0x290 [usb_storage]
[  359.971932] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
[  359.971935]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  359.971936] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  359.971937] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
[  359.971941]  ffff8808027cdc50 0000000000000046 ffff88007c988000
ffff8808027cdfd8
[  359.971943]  00000000001d5800 00000000001d5800 ffff88007c988000
ffff880810ca6bf0
[  359.971946]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
ffff88080c532600
[  359.971948] Call Trace:
[  359.971953]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
[  359.971955]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
[  359.971961]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  359.971964]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  359.971968]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
[  359.971985]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
[  359.971987]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
[  359.971989]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
[  359.971991]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
[  359.971992]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
[  359.971995]  [<ffffffff810c452f>] kthread+0xff/0x120
[  359.971997]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  359.971999]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  359.972001]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  359.972002] 1 lock held by scsi_eh_6/537:
[  359.972003]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
device_reset+0x24/0x50 [usb_storage]
[  359.972008] INFO: task usb-storage:539 blocked for more than 120 seconds.
[  359.972009]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  359.972009] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  359.972010] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
[  359.972012]  ffff8808025ebae0 0000000000000046 ffff880800c28000
ffff8808025ebfd8
[  359.972014]  00000000001d5800 00000000001d5800 ffff880800c28000
7fffffffffffffff
[  359.972016]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
0000000000000000
[  359.972018] Call Trace:
[  359.972020]  [<ffffffff817daad9>] schedule+0x29/0x70
[  359.972021]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
[  359.972025]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  359.972027]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  359.972028]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
[  359.972030]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
[  359.972033]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
[  359.972035]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
[  359.972038]  [<ffffffffa035e4db>]
usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
[  359.972041]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
[  359.972045]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
[usb_storage]
[  359.972048]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
[usb_storage]
[  359.972050]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  359.972052]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  359.972055]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
[usb_storage]
[  359.972059]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
[usb_storage]
[  359.972062]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  359.972065]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  359.972067]  [<ffffffff810c452f>] kthread+0xff/0x120
[  359.972068]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  359.972070]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  359.972071]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  359.972072] 1 lock held by usb-storage/539:
[  359.972073]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
usb_stor_control_thread+0x8a/0x290 [usb_storage]
[  479.904100] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
[  479.904111]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  479.904114] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  479.904118] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
[  479.904131]  ffff8808027cdc50 0000000000000046 ffff88007c988000
ffff8808027cdfd8
[  479.904140]  00000000001d5800 00000000001d5800 ffff88007c988000
ffff880810ca6bf0
[  479.904148]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
ffff88080c532600
[  479.904156] Call Trace:
[  479.904171]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
[  479.904179]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
[  479.904204]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  479.904218]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  479.904232]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
[  479.904243]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
[  479.904251]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
[  479.904258]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
[  479.904266]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
[  479.904274]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
[  479.904282]  [<ffffffff810c452f>] kthread+0xff/0x120
[  479.904290]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  479.904299]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  479.904305]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  479.904310] 1 lock held by scsi_eh_6/537:
[  479.904312]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
device_reset+0x24/0x50 [usb_storage]
[  479.904331] INFO: task usb-storage:539 blocked for more than 120 seconds.
[  479.904334]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  479.904337] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  479.904340] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
[  479.904348]  ffff8808025ebae0 0000000000000046 ffff880800c28000
ffff8808025ebfd8
[  479.904357]  00000000001d5800 00000000001d5800 ffff880800c28000
7fffffffffffffff
[  479.904364]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
0000000000000000
[  479.904372] Call Trace:
[  479.904379]  [<ffffffff817daad9>] schedule+0x29/0x70
[  479.904385]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
[  479.904396]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  479.904404]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  479.904411]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
[  479.904418]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
[  479.904428]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
[  479.904436]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
[  479.904451]  [<ffffffffa035e4db>]
usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
[  479.904465]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
[  479.904480]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
[usb_storage]
[  479.904495]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
[usb_storage]
[  479.904502]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  479.904509]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  479.904523]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
[usb_storage]
[  479.904538]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
[usb_storage]
[  479.904553]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  479.904567]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  479.904573]  [<ffffffff810c452f>] kthread+0xff/0x120
[  479.904580]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  479.904588]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  479.904593]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  479.904597] 1 lock held by usb-storage/539:
[  479.904600]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
usb_stor_control_thread+0x8a/0x290 [usb_storage]
[  599.833322] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
[  599.833326]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  599.833327] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  599.833328] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
[  599.833333]  ffff8808027cdc50 0000000000000046 ffff88007c988000
ffff8808027cdfd8
[  599.833336]  00000000001d5800 00000000001d5800 ffff88007c988000
ffff880810ca6bf0
[  599.833338]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
ffff88080c532600
[  599.833340] Call Trace:
[  599.833346]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
[  599.833348]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
[  599.833355]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  599.833359]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  599.833363]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
[  599.833367]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
[  599.833369]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
[  599.833371]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
[  599.833374]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
[  599.833376]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
[  599.833379]  [<ffffffff810c452f>] kthread+0xff/0x120
[  599.833381]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  599.833384]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  599.833386]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  599.833387] 1 lock held by scsi_eh_6/537:
[  599.833388]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
device_reset+0x24/0x50 [usb_storage]
[  599.833394] INFO: task usb-storage:539 blocked for more than 120 seconds.
[  599.833395]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  599.833396] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  599.833396] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
[  599.833399]  ffff8808025ebae0 0000000000000046 ffff880800c28000
ffff8808025ebfd8
[  599.833401]  00000000001d5800 00000000001d5800 ffff880800c28000
7fffffffffffffff
[  599.833403]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
0000000000000000
[  599.833405] Call Trace:
[  599.833408]  [<ffffffff817daad9>] schedule+0x29/0x70
[  599.833410]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
[  599.833413]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  599.833416]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  599.833418]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
[  599.833420]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
[  599.833423]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
[  599.833425]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
[  599.833430]  [<ffffffffa035e4db>]
usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
[  599.833434]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
[  599.833438]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
[usb_storage]
[  599.833442]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
[usb_storage]
[  599.833444]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  599.833446]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  599.833450]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
[usb_storage]
[  599.833453]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
[usb_storage]
[  599.833457]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  599.833461]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  599.833463]  [<ffffffff810c452f>] kthread+0xff/0x120
[  599.833465]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  599.833467]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  599.833469]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  599.833470] 1 lock held by usb-storage/539:
[  599.833471]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
usb_stor_control_thread+0x8a/0x290 [usb_storage]
[  649.166883] kworker/u16:5 (114) used greatest stack depth: 1992 bytes left
[  719.763710] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
[  719.763715]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  719.763716] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  719.763718] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
[  719.763724]  ffff8808027cdc50 0000000000000046 ffff88007c988000
ffff8808027cdfd8
[  719.763728]  00000000001d5800 00000000001d5800 ffff88007c988000
ffff880810ca6bf0
[  719.763732]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
ffff88080c532600
[  719.763735] Call Trace:
[  719.763743]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
[  719.763746]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
[  719.763756]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  719.763762]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
[  719.763768]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
[  719.763774]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
[  719.763777]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
[  719.763780]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
[  719.763784]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
[  719.763787]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
[  719.763791]  [<ffffffff810c452f>] kthread+0xff/0x120
[  719.763794]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  719.763798]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  719.763801]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  719.763803] 1 lock held by scsi_eh_6/537:
[  719.763804]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
device_reset+0x24/0x50 [usb_storage]
[  719.763812] INFO: task usb-storage:539 blocked for more than 120 seconds.
[  719.763814]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
[  719.763815] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[  719.763816] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
[  719.763820]  ffff8808025ebae0 0000000000000046 ffff880800c28000
ffff8808025ebfd8
[  719.763823]  00000000001d5800 00000000001d5800 ffff880800c28000
7fffffffffffffff
[  719.763827]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
0000000000000000
[  719.763830] Call Trace:
[  719.763833]  [<ffffffff817daad9>] schedule+0x29/0x70
[  719.763836]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
[  719.763841]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  719.763844]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  719.763848]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
[  719.763851]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
[  719.763855]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
[  719.763859]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
[  719.763865]  [<ffffffffa035e4db>]
usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
[  719.763871]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
[  719.763878]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
[usb_storage]
[  719.763884]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
[usb_storage]
[  719.763887]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
[  719.763890]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
[  719.763896]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
[usb_storage]
[  719.763903]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
[usb_storage]
[  719.763909]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  719.763915]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
[usb_storage]
[  719.763918]  [<ffffffff810c452f>] kthread+0xff/0x120
[  719.763920]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  719.763924]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
[  719.763926]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
[  719.763928] 1 lock held by usb-storage/539:
[  719.763929]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
usb_stor_control_thread+0x8a/0x290 [usb_storage]

-- 
You are receiving this mail because:
You are the assignee for the bug.

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds.
       [not found] ` <bug-77631-11613-3bo0kxnWaOQUvHkbgXJLS5sdmw4N0Rt+2LY78lusg7I@public.gmane.org/>
@ 2014-06-10 17:31   ` James Bottomley
  2014-06-10 20:49     ` Alan Stern
  0 siblings, 1 reply; 7+ messages in thread
From: James Bottomley @ 2014-06-10 17:31 UTC (permalink / raw)
  To: bugzilla-daemon-590EEB7GvNiWaY/ihj7yzEB+6BGkLq7r
  Cc: linux-scsi-u79uwXL29TY76Z2rM5mHXA, linux-usb-u79uwXL29TY76Z2rM5mHXA

>From the trace below, this looks to be a USB issue (USB added to cc):
the scsi error handler thread is waiting for usb storage to complete the
reset.  It's a 3.14.5 kernel, so the previous reset hang because of
spurious sense requests should be fixed.

James


On Tue, 2014-06-10 at 16:50 +0000, bugzilla-daemon-590EEB7GvNiWaY/ihj7yzEB+6BGkLq7r@public.gmane.org
wrote:
> https://bugzilla.kernel.org/show_bug.cgi?id=77631
> 
>             Bug ID: 77631
>            Summary: task scsi_eh_6:537 blocked for more than 120 seconds.
>            Product: IO/Storage
>            Version: 2.5
>     Kernel Version: 3.14.6
>           Hardware: All
>                 OS: Linux
>               Tree: Mainline
>             Status: NEW
>           Severity: normal
>           Priority: P1
>          Component: SCSI
>           Assignee: linux-scsi-u79uwXL29TY76Z2rM5mHXA@public.gmane.org
>           Reporter: mikhail.v.gavrilov-Re5JQEeQqe8AvxtiuMwx3w@public.gmane.org
>         Regression: No
> 
> Created attachment 138941
>   --> https://bugzilla.kernel.org/attachment.cgi?id=138941&action=edit
> kernel log
> 
> task scsi_eh_6:537 blocked for more than 120 seconds.
> 
> 
> [  240.036323] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
> [  240.036333]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  240.036337] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  240.036341] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
> [  240.036355]  ffff8808027cdc50 0000000000000046 ffff88007c988000
> ffff8808027cdfd8
> [  240.036366]  00000000001d5800 00000000001d5800 ffff88007c988000
> ffff880810ca6bf0
> [  240.036375]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
> ffff88080c532600
> [  240.036384] Call Trace:
> [  240.036400]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
> [  240.036409]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
> [  240.036434]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  240.036450]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  240.036466]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
> [  240.036478]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
> [  240.036487]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
> [  240.036495]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
> [  240.036504]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
> [  240.036512]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
> [  240.036522]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  240.036530]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  240.036540]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  240.036547]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  240.036553] 1 lock held by scsi_eh_6/537:
> [  240.036555]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
> device_reset+0x24/0x50 [usb_storage]
> [  240.036575] INFO: task usb-storage:539 blocked for more than 120 seconds.
> [  240.036579]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  240.036582] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  240.036585] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
> [  240.036595]  ffff8808025ebae0 0000000000000046 ffff880800c28000
> ffff8808025ebfd8
> [  240.036604]  00000000001d5800 00000000001d5800 ffff880800c28000
> 7fffffffffffffff
> [  240.036612]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
> 0000000000000000
> [  240.036621] Call Trace:
> [  240.036629]  [<ffffffff817daad9>] schedule+0x29/0x70
> [  240.036637]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
> [  240.036648]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  240.036657]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  240.036665]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
> [  240.036673]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
> [  240.036684]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
> [  240.036692]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
> [  240.036709]  [<ffffffffa035e4db>]
> usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
> [  240.036725]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
> [  240.036741]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
> [usb_storage]
> [  240.036758]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
> [usb_storage]
> [  240.036766]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  240.036774]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  240.036790]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
> [usb_storage]
> [  240.036807]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
> [usb_storage]
> [  240.036824]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  240.036840]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  240.036847]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  240.036854]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  240.036862]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  240.036869]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  240.036873] 1 lock held by usb-storage/539:
> [  240.036876]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
> usb_stor_control_thread+0x8a/0x290 [usb_storage]
> [  359.971932] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
> [  359.971935]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  359.971936] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  359.971937] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
> [  359.971941]  ffff8808027cdc50 0000000000000046 ffff88007c988000
> ffff8808027cdfd8
> [  359.971943]  00000000001d5800 00000000001d5800 ffff88007c988000
> ffff880810ca6bf0
> [  359.971946]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
> ffff88080c532600
> [  359.971948] Call Trace:
> [  359.971953]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
> [  359.971955]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
> [  359.971961]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  359.971964]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  359.971968]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
> [  359.971985]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
> [  359.971987]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
> [  359.971989]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
> [  359.971991]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
> [  359.971992]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
> [  359.971995]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  359.971997]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  359.971999]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  359.972001]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  359.972002] 1 lock held by scsi_eh_6/537:
> [  359.972003]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
> device_reset+0x24/0x50 [usb_storage]
> [  359.972008] INFO: task usb-storage:539 blocked for more than 120 seconds.
> [  359.972009]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  359.972009] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  359.972010] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
> [  359.972012]  ffff8808025ebae0 0000000000000046 ffff880800c28000
> ffff8808025ebfd8
> [  359.972014]  00000000001d5800 00000000001d5800 ffff880800c28000
> 7fffffffffffffff
> [  359.972016]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
> 0000000000000000
> [  359.972018] Call Trace:
> [  359.972020]  [<ffffffff817daad9>] schedule+0x29/0x70
> [  359.972021]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
> [  359.972025]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  359.972027]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  359.972028]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
> [  359.972030]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
> [  359.972033]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
> [  359.972035]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
> [  359.972038]  [<ffffffffa035e4db>]
> usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
> [  359.972041]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
> [  359.972045]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
> [usb_storage]
> [  359.972048]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
> [usb_storage]
> [  359.972050]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  359.972052]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  359.972055]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
> [usb_storage]
> [  359.972059]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
> [usb_storage]
> [  359.972062]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  359.972065]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  359.972067]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  359.972068]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  359.972070]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  359.972071]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  359.972072] 1 lock held by usb-storage/539:
> [  359.972073]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
> usb_stor_control_thread+0x8a/0x290 [usb_storage]
> [  479.904100] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
> [  479.904111]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  479.904114] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  479.904118] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
> [  479.904131]  ffff8808027cdc50 0000000000000046 ffff88007c988000
> ffff8808027cdfd8
> [  479.904140]  00000000001d5800 00000000001d5800 ffff88007c988000
> ffff880810ca6bf0
> [  479.904148]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
> ffff88080c532600
> [  479.904156] Call Trace:
> [  479.904171]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
> [  479.904179]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
> [  479.904204]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  479.904218]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  479.904232]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
> [  479.904243]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
> [  479.904251]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
> [  479.904258]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
> [  479.904266]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
> [  479.904274]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
> [  479.904282]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  479.904290]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  479.904299]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  479.904305]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  479.904310] 1 lock held by scsi_eh_6/537:
> [  479.904312]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
> device_reset+0x24/0x50 [usb_storage]
> [  479.904331] INFO: task usb-storage:539 blocked for more than 120 seconds.
> [  479.904334]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  479.904337] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  479.904340] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
> [  479.904348]  ffff8808025ebae0 0000000000000046 ffff880800c28000
> ffff8808025ebfd8
> [  479.904357]  00000000001d5800 00000000001d5800 ffff880800c28000
> 7fffffffffffffff
> [  479.904364]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
> 0000000000000000
> [  479.904372] Call Trace:
> [  479.904379]  [<ffffffff817daad9>] schedule+0x29/0x70
> [  479.904385]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
> [  479.904396]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  479.904404]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  479.904411]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
> [  479.904418]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
> [  479.904428]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
> [  479.904436]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
> [  479.904451]  [<ffffffffa035e4db>]
> usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
> [  479.904465]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
> [  479.904480]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
> [usb_storage]
> [  479.904495]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
> [usb_storage]
> [  479.904502]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  479.904509]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  479.904523]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
> [usb_storage]
> [  479.904538]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
> [usb_storage]
> [  479.904553]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  479.904567]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  479.904573]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  479.904580]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  479.904588]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  479.904593]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  479.904597] 1 lock held by usb-storage/539:
> [  479.904600]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
> usb_stor_control_thread+0x8a/0x290 [usb_storage]
> [  599.833322] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
> [  599.833326]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  599.833327] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  599.833328] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
> [  599.833333]  ffff8808027cdc50 0000000000000046 ffff88007c988000
> ffff8808027cdfd8
> [  599.833336]  00000000001d5800 00000000001d5800 ffff88007c988000
> ffff880810ca6bf0
> [  599.833338]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
> ffff88080c532600
> [  599.833340] Call Trace:
> [  599.833346]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
> [  599.833348]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
> [  599.833355]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  599.833359]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  599.833363]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
> [  599.833367]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
> [  599.833369]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
> [  599.833371]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
> [  599.833374]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
> [  599.833376]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
> [  599.833379]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  599.833381]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  599.833384]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  599.833386]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  599.833387] 1 lock held by scsi_eh_6/537:
> [  599.833388]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
> device_reset+0x24/0x50 [usb_storage]
> [  599.833394] INFO: task usb-storage:539 blocked for more than 120 seconds.
> [  599.833395]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  599.833396] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  599.833396] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
> [  599.833399]  ffff8808025ebae0 0000000000000046 ffff880800c28000
> ffff8808025ebfd8
> [  599.833401]  00000000001d5800 00000000001d5800 ffff880800c28000
> 7fffffffffffffff
> [  599.833403]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
> 0000000000000000
> [  599.833405] Call Trace:
> [  599.833408]  [<ffffffff817daad9>] schedule+0x29/0x70
> [  599.833410]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
> [  599.833413]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  599.833416]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  599.833418]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
> [  599.833420]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
> [  599.833423]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
> [  599.833425]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
> [  599.833430]  [<ffffffffa035e4db>]
> usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
> [  599.833434]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
> [  599.833438]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
> [usb_storage]
> [  599.833442]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
> [usb_storage]
> [  599.833444]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  599.833446]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  599.833450]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
> [usb_storage]
> [  599.833453]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
> [usb_storage]
> [  599.833457]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  599.833461]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  599.833463]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  599.833465]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  599.833467]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  599.833469]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  599.833470] 1 lock held by usb-storage/539:
> [  599.833471]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
> usb_stor_control_thread+0x8a/0x290 [usb_storage]
> [  649.166883] kworker/u16:5 (114) used greatest stack depth: 1992 bytes left
> [  719.763710] INFO: task scsi_eh_6:537 blocked for more than 120 seconds.
> [  719.763715]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  719.763716] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  719.763718] scsi_eh_6       D ffff880813528000  6184   537      2 0x00000000
> [  719.763724]  ffff8808027cdc50 0000000000000046 ffff88007c988000
> ffff8808027cdfd8
> [  719.763728]  00000000001d5800 00000000001d5800 ffff88007c988000
> ffff880810ca6bf0
> [  719.763732]  ffff880810ca6bf8 0000000000000246 ffff88007c988000
> ffff88080c532600
> [  719.763735] Call Trace:
> [  719.763743]  [<ffffffff817dafe1>] schedule_preempt_disabled+0x31/0x80
> [  719.763746]  [<ffffffff817dc204>] mutex_lock_nested+0x194/0x430
> [  719.763756]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  719.763762]  [<ffffffffa035d9b4>] ? device_reset+0x24/0x50 [usb_storage]
> [  719.763768]  [<ffffffffa035d9b4>] device_reset+0x24/0x50 [usb_storage]
> [  719.763774]  [<ffffffff81523f0a>] scsi_try_bus_device_reset+0x2a/0x50
> [  719.763777]  [<ffffffff8152601f>] scsi_eh_ready_devs+0x4df/0xc20
> [  719.763780]  [<ffffffff81527886>] ? scsi_eh_get_sense+0x176/0x2a0
> [  719.763784]  [<ffffffff81527eec>] scsi_error_handler+0x53c/0x830
> [  719.763787]  [<ffffffff815279b0>] ? scsi_eh_get_sense+0x2a0/0x2a0
> [  719.763791]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  719.763794]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  719.763798]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  719.763801]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  719.763803] 1 lock held by scsi_eh_6/537:
> [  719.763804]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035d9b4>]
> device_reset+0x24/0x50 [usb_storage]
> [  719.763812] INFO: task usb-storage:539 blocked for more than 120 seconds.
> [  719.763814]       Not tainted 3.14.6-200.fc20.x86_64+debug #1
> [  719.763815] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
> message.
> [  719.763816] usb-storage     D ffff88081351a590  5032   539      2 0x00000000
> [  719.763820]  ffff8808025ebae0 0000000000000046 ffff880800c28000
> ffff8808025ebfd8
> [  719.763823]  00000000001d5800 00000000001d5800 ffff880800c28000
> 7fffffffffffffff
> [  719.763827]  ffff880810ca6dd0 ffff880810ca6dc8 ffff880800c28000
> 0000000000000000
> [  719.763830] Call Trace:
> [  719.763833]  [<ffffffff817daad9>] schedule+0x29/0x70
> [  719.763836]  [<ffffffff817d9a59>] schedule_timeout+0x1f9/0x350
> [  719.763841]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  719.763844]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  719.763848]  [<ffffffff810fbb75>] ? trace_hardirqs_on_caller+0x105/0x1d0
> [  719.763851]  [<ffffffff817dc02c>] wait_for_completion+0xfc/0x140
> [  719.763855]  [<ffffffff810d9a50>] ? wake_up_state+0x20/0x20
> [  719.763859]  [<ffffffff815845fd>] usb_sg_wait+0x12d/0x190
> [  719.763865]  [<ffffffffa035e4db>]
> usb_stor_bulk_transfer_sglist.part.4+0x8b/0xf0 [usb_storage]
> [  719.763871]  [<ffffffffa035e5b1>] usb_stor_bulk_srb+0x71/0x80 [usb_storage]
> [  719.763878]  [<ffffffffa035e71c>] usb_stor_Bulk_transport+0x15c/0x360
> [usb_storage]
> [  719.763884]  [<ffffffffa035ef9b>] usb_stor_invoke_transport+0x3b/0x570
> [usb_storage]
> [  719.763887]  [<ffffffff810fb9e9>] ? mark_held_locks+0xb9/0x140
> [  719.763890]  [<ffffffff817dff8c>] ? _raw_spin_unlock_irq+0x2c/0x40
> [  719.763896]  [<ffffffffa035dbce>] usb_stor_transparent_scsi_command+0xe/0x10
> [usb_storage]
> [  719.763903]  [<ffffffffa035fe96>] usb_stor_control_thread+0x176/0x290
> [usb_storage]
> [  719.763909]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  719.763915]  [<ffffffffa035fd20>] ? fill_inquiry_response+0x20/0x20
> [usb_storage]
> [  719.763918]  [<ffffffff810c452f>] kthread+0xff/0x120
> [  719.763920]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  719.763924]  [<ffffffff817eaafc>] ret_from_fork+0x7c/0xb0
> [  719.763926]  [<ffffffff810c4430>] ? insert_kthread_work+0x80/0x80
> [  719.763928] 1 lock held by usb-storage/539:
> [  719.763929]  #0:  (&us_interface_key[i]){+.+.+.}, at: [<ffffffffa035fdaa>]
> usb_stor_control_thread+0x8a/0x290 [usb_storage]
> 



--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majordomo-u79uwXL29TY76Z2rM5mHXA@public.gmane.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds.
  2014-06-10 17:31   ` James Bottomley
@ 2014-06-10 20:49     ` Alan Stern
  0 siblings, 0 replies; 7+ messages in thread
From: Alan Stern @ 2014-06-10 20:49 UTC (permalink / raw)
  To: James Bottomley
  Cc: mikhail.v.gavrilov, bugzilla-daemon, SCSI development list, USB list

On Tue, 10 Jun 2014, James Bottomley wrote:

> From the trace below, this looks to be a USB issue (USB added to cc):
> the scsi error handler thread is waiting for usb storage to complete the
> reset.  It's a 3.14.5 kernel, so the previous reset hang because of
> spurious sense requests should be fixed.
> 
> James
> 
> 
> On Tue, 2014-06-10 at 16:50 +0000, bugzilla-daemon@bugzilla.kernel.org
> wrote:
> > https://bugzilla.kernel.org/show_bug.cgi?id=77631
> > 
> >             Bug ID: 77631
> >            Summary: task scsi_eh_6:537 blocked for more than 120 seconds.
> >            Product: IO/Storage
> >            Version: 2.5
> >     Kernel Version: 3.14.6
> >           Hardware: All
> >                 OS: Linux
> >               Tree: Mainline
> >             Status: NEW
> >           Severity: normal
> >           Priority: P1
> >          Component: SCSI
> >           Assignee: linux-scsi@vger.kernel.org
> >           Reporter: mikhail.v.gavrilov@gmail.com
> >         Regression: No
> > 
> > Created attachment 138941
> >   --> https://bugzilla.kernel.org/attachment.cgi?id=138941&action=edit
> > kernel log
> > 
> > task scsi_eh_6:537 blocked for more than 120 seconds.

This line from earlier in the kernel log is highly suspicious:

> [   46.330470] usb-storage: Error in queuecommand_lck: us->srb = ffff88080c532600

This means that the SCSI midlayer called the queuecommand routine twice 
with no intervening completion, even though the maximum queue depth is 
only 1.

Mikhail, is this bug reproducible?  If it is, can you post a usbmon 
trace showing the events leading up to the bug?

Does the bug occur if the device is plugged into a USB-2 bus rather 
than a USB-3 bus?

Alan Stern


^ permalink raw reply	[flat|nested] 7+ messages in thread

* [Bug 77631] task scsi_eh_6:537 blocked for more than 120 seconds.
  2014-06-10 16:50 [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds bugzilla-daemon
       [not found] ` <bug-77631-11613-3bo0kxnWaOQUvHkbgXJLS5sdmw4N0Rt+2LY78lusg7I@public.gmane.org/>
@ 2014-06-10 20:55 ` bugzilla-daemon
  2014-06-10 21:44 ` bugzilla-daemon
                   ` (2 subsequent siblings)
  4 siblings, 0 replies; 7+ messages in thread
From: bugzilla-daemon @ 2014-06-10 20:55 UTC (permalink / raw)
  To: linux-scsi

https://bugzilla.kernel.org/show_bug.cgi?id=77631

--- Comment #1 from Alan Stern <stern@rowland.harvard.edu> ---
On Tue, 10 Jun 2014, James Bottomley wrote:

> From the trace below, this looks to be a USB issue (USB added to cc):
> the scsi error handler thread is waiting for usb storage to complete the
> reset.  It's a 3.14.5 kernel, so the previous reset hang because of
> spurious sense requests should be fixed.
> 
> James
> 
> 
> On Tue, 2014-06-10 at 16:50 +0000, bugzilla-daemon@bugzilla.kernel.org
> wrote:
> > https://bugzilla.kernel.org/show_bug.cgi?id=77631
> > 
> >             Bug ID: 77631
> >            Summary: task scsi_eh_6:537 blocked for more than 120 seconds.
> >            Product: IO/Storage
> >            Version: 2.5
> >     Kernel Version: 3.14.6
> >           Hardware: All
> >                 OS: Linux
> >               Tree: Mainline
> >             Status: NEW
> >           Severity: normal
> >           Priority: P1
> >          Component: SCSI
> >           Assignee: linux-scsi@vger.kernel.org
> >           Reporter: mikhail.v.gavrilov@gmail.com
> >         Regression: No
> > 
> > Created attachment 138941
> >   --> https://bugzilla.kernel.org/attachment.cgi?id=138941&action=edit
> > kernel log
> > 
> > task scsi_eh_6:537 blocked for more than 120 seconds.

This line from earlier in the kernel log is highly suspicious:

> [   46.330470] usb-storage: Error in queuecommand_lck: us->srb = ffff88080c532600

This means that the SCSI midlayer called the queuecommand routine twice 
with no intervening completion, even though the maximum queue depth is 
only 1.

Mikhail, is this bug reproducible?  If it is, can you post a usbmon 
trace showing the events leading up to the bug?

Does the bug occur if the device is plugged into a USB-2 bus rather 
than a USB-3 bus?

Alan Stern

-- 
You are receiving this mail because:
You are the assignee for the bug.

^ permalink raw reply	[flat|nested] 7+ messages in thread

* [Bug 77631] task scsi_eh_6:537 blocked for more than 120 seconds.
  2014-06-10 16:50 [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds bugzilla-daemon
       [not found] ` <bug-77631-11613-3bo0kxnWaOQUvHkbgXJLS5sdmw4N0Rt+2LY78lusg7I@public.gmane.org/>
  2014-06-10 20:55 ` [Bug 77631] " bugzilla-daemon
@ 2014-06-10 21:44 ` bugzilla-daemon
  2014-06-10 21:49 ` bugzilla-daemon
  2014-06-10 21:50 ` bugzilla-daemon
  4 siblings, 0 replies; 7+ messages in thread
From: bugzilla-daemon @ 2014-06-10 21:44 UTC (permalink / raw)
  To: linux-scsi

https://bugzilla.kernel.org/show_bug.cgi?id=77631

--- Comment #2 from Mikhail <mikhail.v.gavrilov@gmail.com> ---
This occurred when I did first reboot after kernel update from 3.14.5 to
3.14.6.
After second reboot I have not seen this issue.
And I did not plug/unplug any USB devices when it occurred.

-- 
You are receiving this mail because:
You are the assignee for the bug.

^ permalink raw reply	[flat|nested] 7+ messages in thread

* [Bug 77631] task scsi_eh_6:537 blocked for more than 120 seconds.
  2014-06-10 16:50 [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds bugzilla-daemon
                   ` (2 preceding siblings ...)
  2014-06-10 21:44 ` bugzilla-daemon
@ 2014-06-10 21:49 ` bugzilla-daemon
  2014-06-10 21:50 ` bugzilla-daemon
  4 siblings, 0 replies; 7+ messages in thread
From: bugzilla-daemon @ 2014-06-10 21:49 UTC (permalink / raw)
  To: linux-scsi

https://bugzilla.kernel.org/show_bug.cgi?id=77631

--- Comment #3 from Mikhail <mikhail.v.gavrilov@gmail.com> ---
When I reconnect my USB3.0 10 port hub only occurs this:

[  835.657491] usb 4-3: USB disconnect, device number 3
[  835.657506] usb 4-3.4: USB disconnect, device number 11
[  835.658118] usb 4-3.4: Failed to set U1 timeout to 0x0,error code -19
[  835.658134] usb 4-3.4: Failed to set U1 timeout to 0x43,error code -19
[  835.658146] usb 4-3.4: Failed to set U2 timeout to 0x28,error code -19
[  835.694393] usb 4-3.4: Failed to set U1 timeout to 0x0,error code -19
[  835.694434] usb 4-3.4: Failed to set U1 timeout to 0x29,error code -19
[  835.694440] usb 4-3.4: Failed to set U2 timeout to 0x28,error code -19
[  835.802188] usb 3-3: USB disconnect, device number 11
[  835.802191] usb 3-3.1: USB disconnect, device number 12
[  835.802193] usb 3-3.1.3: USB disconnect, device number 14
[  835.868161] usb 3-3.1.4: USB disconnect, device number 15
[  835.875955] usb 3-3.1.6: USB disconnect, device number 16
[  835.914734] usb 3-3.3: USB disconnect, device number 13
[  841.411016] usb 3-7: USB disconnect, device number 3
[  859.635511] usb 3-7: new high-speed USB device number 20 using xhci_hcd
[  859.800823] usb 3-7: New USB device found, idVendor=2109, idProduct=2812
[  859.800833] usb 3-7: New USB device strings: Mfr=0, Product=1,
SerialNumber=0
[  859.800838] usb 3-7: Product: USB 2.0 HUB

[  859.803390] hub 3-7:1.0: USB hub found
[  859.803648] hub 3-7:1.0: 4 ports detected
[  860.088189] usb 3-7.1: new high-speed USB device number 21 using xhci_hcd
[  860.174264] usb 3-7.1: New USB device found, idVendor=1a40, idProduct=0201
[  860.174266] usb 3-7.1: New USB device strings: Mfr=0, Product=1,
SerialNumber=0
[  860.174268] usb 3-7.1: Product: USB 2.0 Hub [MTT]
[  860.174915] hub 3-7.1:1.0: USB hub found
[  860.174941] hub 3-7.1:1.0: 7 ports detected
[  860.251194] usb 3-7.3: new high-speed USB device number 22 using xhci_hcd
[  860.338906] usb 3-7.3: New USB device found, idVendor=18d1, idProduct=4ee1
[  860.338908] usb 3-7.3: New USB device strings: Mfr=1, Product=2,
SerialNumber=3
[  860.338909] usb 3-7.3: Product: Nexus 5
[  860.338910] usb 3-7.3: Manufacturer: LGE
[  860.338911] usb 3-7.3: SerialNumber: 07606f5400e1b31a
[  860.375934] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.375967] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376052] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376646] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376686] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376723] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376763] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376803] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376906] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.376942] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377140] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377215] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377254] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377369] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377451] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377494] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377534] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377570] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377651] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377693] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377745] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.377828] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378002] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378120] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378160] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378198] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378240] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378279] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378320] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378363] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378414] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378455] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378501] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378665] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378704] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378747] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378787] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378828] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378881] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378920] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.378970] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379011] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379049] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379211] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379248] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379329] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379408] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379489] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379530] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379574] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379651] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379731] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379768] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379889] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.379979] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380011] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380086] xhci_hcd 0000:00:14.0: URB transfer length is wrong, xHC issue?
req. len = 4, act. len = 4294967292
[  860.380095] hub 3-7.1:1.0: hub_port_status failed (err = 0)
[  860.380131] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380316] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380358] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380437] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380480] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380518] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380678] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380716] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380797] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380881] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380918] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.380965] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381036] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381119] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381158] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381198] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381318] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381358] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381436] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381519] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381557] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381640] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381680] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381757] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381801] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381848] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.381996] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382129] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382163] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382241] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382328] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382366] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382447] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382495] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382533] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382574] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382694] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382733] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382773] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382854] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382899] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.382938] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383019] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383065] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383106] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383145] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383306] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383349] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383423] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383466] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383502] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383583] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383625] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383704] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383742] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383787] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383945] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.383982] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384055] xhci_hcd 0000:00:14.0: URB transfer length is wrong, xHC issue?
req. len = 4, act. len = 4294967292
[  860.384121] hub 3-7.1:1.0: hub_port_status failed (err = 0)
[  860.384161] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384201] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384244] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384279] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384360] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384439] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384518] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384679] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384758] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384876] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.384919] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385001] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385081] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385121] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385199] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385283] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385321] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385481] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385520] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385560] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385600] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385640] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385680] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385721] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385767] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385803] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.385886] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386043] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386123] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386202] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386283] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386362] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386442] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386522] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386603] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386682] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386762] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.386923] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387002] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387088] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387124] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387202] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387281] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387361] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387443] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387525] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387601] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387726] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387762] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387845] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387929] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.387963] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388042] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388122] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388203] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388282] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388362] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388522] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388595] xhci_hcd 0000:00:14.0: URB transfer length is wrong, xHC issue?
req. len = 4, act. len = 4294967292
[  860.388603] hub 3-7.1:1.0: hub_port_status failed (err = 0)
[  860.388642] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388721] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388801] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388886] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.388962] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389042] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389121] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389201] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389361] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389441] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389521] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389601] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389681] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389761] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389844] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389909] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.389943] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390021] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390181] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390261] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390341] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390421] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390501] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390581] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390661] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390742] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390821] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.390902] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391061] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391141] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391221] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391300] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391380] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391460] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391540] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391621] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391700] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391780] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.391940] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392020] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392100] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392180] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392260] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392340] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392420] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392500] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392580] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392662] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392820] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392901] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.392980] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393060] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393139] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393220] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393299] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393380] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393459] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393539] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393693] xhci_hcd 0000:00:14.0: URB transfer length is wrong, xHC issue?
req. len = 4, act. len = 4294967292
[  860.393701] hub 3-7.1:1.0: hub_port_status failed (err = 0)
[  860.393739] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393819] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393900] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.393979] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394059] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394139] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394223] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394259] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394339] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394502] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394539] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394619] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394698] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394785] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394836] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.394873] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.395196] usb 3-7.3: USB disconnect, device number 22
[  860.397907] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.397995] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398035] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398188] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398268] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398349] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398428] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398508] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398588] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398669] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398751] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398788] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398872] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.398990] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399068] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399148] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399228] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399308] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399388] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399468] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399550] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399629] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399707] hub 3-7.1:1.0: hub_port_status failed (err = -71)
[  860.399781] xhci_hcd 0000:00:14.0: URB transfer length is wrong, xHC issue?
req. len = 0, act. len = 4294967288
[  862.415413] usb 3-7: reset high-speed USB device number 20 using xhci_hcd
[  862.416046] xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for
slot 29.
[  862.568894] usb 3-7: reset high-speed USB device number 20 using xhci_hcd
[  862.568984] xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for
slot 29.
[  862.721812] usb 3-7: reset high-speed USB device number 20 using xhci_hcd
[  862.733416] xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with
disabled ep ffff88007b9e4ec0
[  863.029865] usb 3-7.1: reset high-speed USB device number 21 using xhci_hcd
[  863.029893] xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for
slot 30.
[  863.104624] usb 3-7.1: reset high-speed USB device number 21 using xhci_hcd
[  863.104655] xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for
slot 30.
[  863.179482] usb 3-7.1: reset high-speed USB device number 21 using xhci_hcd
[  863.190550] xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with
disabled ep ffff88007b9e4940
[  863.468430] usb 3-7.3: new high-speed USB device number 23 using xhci_hcd
[  863.561070] usb 3-7.3: New USB device found, idVendor=18d1, idProduct=4ee1
[  863.561080] usb 3-7.3: New USB device strings: Mfr=1, Product=2,
SerialNumber=3
[  863.561086] usb 3-7.3: Product: Nexus 5
[  863.561090] usb 3-7.3: Manufacturer: LGE
[  863.561094] usb 3-7.3: SerialNumber: 07606f5400e1b31a
[  863.627036] usb 3-7.1.3: new low-speed USB device number 24 using xhci_hcd
[  863.708614] usb 3-7.1.3: New USB device found, idVendor=046d, idProduct=c326
[  863.708618] usb 3-7.1.3: New USB device strings: Mfr=1, Product=2,
SerialNumber=0
[  863.708620] usb 3-7.1.3: Product: USB Keyboard
[  863.708622] usb 3-7.1.3: Manufacturer: Logitech
[  863.709044] usb 3-7.1.3: ep 0x81 - rounding interval to 64 microframes, ep
desc says 80 microframes
[  863.709052] usb 3-7.1.3: ep 0x82 - rounding interval to 64 microframes, ep
desc says 80 microframes
[  863.715126] input: Logitech USB Keyboard as
/devices/pci0000:00/0000:00:14.0/usb3/3-7/3-7.1/3-7.1.3/3-7.1.3:1.0/0003:046D:C326.000E/input/input23
[  863.715693] hid-generic 0003:046D:C326.000E: input,hidraw0: USB HID v1.10
Keyboard [Logitech USB Keyboard] on usb-0000:00:14.0-7.1.3/input0
[  863.721843] input: Logitech USB Keyboard as
/devices/pci0000:00/0000:00:14.0/usb3/3-7/3-7.1/3-7.1.3/3-7.1.3:1.1/0003:046D:C326.000F/input/input24
[  863.722406] hid-generic 0003:046D:C326.000F: input,hiddev0,hidraw1: USB HID
v1.10 Device [Logitech USB Keyboard] on usb-0000:00:14.0-7.1.3/input1
[  863.783928] usb 3-7.1.4: new full-speed USB device number 25 using xhci_hcd
[  864.072776] usb 3-7.1.4: New USB device found, idVendor=0a12, idProduct=0001
[  864.072787] usb 3-7.1.4: New USB device strings: Mfr=0, Product=2,
SerialNumber=0
[  864.072792] usb 3-7.1.4: Product: BT2.0
[  864.141839] usb 3-7.1.6: new full-speed USB device number 26 using xhci_hcd
[  864.218945] usb 3-7.1.6: New USB device found, idVendor=046d, idProduct=c52b
[  864.218955] usb 3-7.1.6: New USB device strings: Mfr=1, Product=2,
SerialNumber=0
[  864.218960] usb 3-7.1.6: Product: USB Receiver
[  864.218965] usb 3-7.1.6: Manufacturer: Logitech
[  864.232193] logitech-djreceiver 0003:046D:C52B.0012: hiddev0,hidraw2: USB
HID v1.11 Device [Logitech USB Receiver] on usb-0000:00:14.0-7.1.6/input2
[  864.291867] input: Logitech Unifying Device. Wireless PID:4026 as
/devices/pci0000:00/0000:00:14.0/usb3/3-7/3-7.1/3-7.1.6/3-7.1.6:1.2/0003:046D:C52B.0012/0003:046D:C52B.0013/input/input25
[  864.310086] logitech-djdevice 0003:046D:C52B.0013: input,hidraw3: USB HID
v1.11 Keyboard [Logitech Unifying Device. Wireless PID:4026] on
usb-0000:00:14.0-7.1.6:1
[  865.765895] usb 3-7.4: new high-speed USB device number 27 using xhci_hcd
[  865.852246] usb 3-7.4: New USB device found, idVendor=8564, idProduct=1000
[  865.852249] usb 3-7.4: New USB device strings: Mfr=1, Product=2,
SerialNumber=3
[  865.852251] usb 3-7.4: Product: Mass Storage Device
[  865.852253] usb 3-7.4: Manufacturer: JetFlash
[  865.852254] usb 3-7.4: SerialNumber: 3988821812
[  865.853131] usb-storage 3-7.4:1.0: USB Mass Storage device detected
[  865.853702] scsi8 : usb-storage 3-7.4:1.0
[  866.855460] scsi 8:0:0:0: Direct-Access     JetFlash Transcend 32GB   1.00
PQ: 0 ANSI: 5
[  866.856300] sd 8:0:0:0: Attached scsi generic sg2 type 0
[  866.856316] sd 8:0:0:0: [sdc] 61741056 512-byte logical blocks: (31.6
GB/29.4 GiB)
[  866.856479] sd 8:0:0:0: [sdc] Write Protect is off
[  866.856481] sd 8:0:0:0: [sdc] Mode Sense: 23 00 00 00
[  866.856630] sd 8:0:0:0: [sdc] Write cache: disabled, read cache: disabled,
doesn't support DPO or FUA
[  866.862959]  sdc: sdc1 sdc2 sdc3
[  866.865949] sd 8:0:0:0: [sdc] Attached SCSI removable disk
[  867.162701] ISO 9660 Extensions: Microsoft Joliet Level 3
[  867.164229] ISO 9660 Extensions: RRIP_1991A
[  867.164254] SELinux: initialized (dev sdc1, type iso9660), uses
genfs_contexts

-- 
You are receiving this mail because:
You are the assignee for the bug.

^ permalink raw reply	[flat|nested] 7+ messages in thread

* [Bug 77631] task scsi_eh_6:537 blocked for more than 120 seconds.
  2014-06-10 16:50 [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds bugzilla-daemon
                   ` (3 preceding siblings ...)
  2014-06-10 21:49 ` bugzilla-daemon
@ 2014-06-10 21:50 ` bugzilla-daemon
  4 siblings, 0 replies; 7+ messages in thread
From: bugzilla-daemon @ 2014-06-10 21:50 UTC (permalink / raw)
  To: linux-scsi

https://bugzilla.kernel.org/show_bug.cgi?id=77631

--- Comment #4 from Mikhail <mikhail.v.gavrilov@gmail.com> ---
Created attachment 138991
  --> https://bugzilla.kernel.org/attachment.cgi?id=138991&action=edit
kernel log (second reboot) and plug/unplug USB3.0 hub

-- 
You are receiving this mail because:
You are the assignee for the bug.

^ permalink raw reply	[flat|nested] 7+ messages in thread

end of thread, other threads:[~2014-06-10 21:50 UTC | newest]

Thread overview: 7+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2014-06-10 16:50 [Bug 77631] New: task scsi_eh_6:537 blocked for more than 120 seconds bugzilla-daemon
     [not found] ` <bug-77631-11613-3bo0kxnWaOQUvHkbgXJLS5sdmw4N0Rt+2LY78lusg7I@public.gmane.org/>
2014-06-10 17:31   ` James Bottomley
2014-06-10 20:49     ` Alan Stern
2014-06-10 20:55 ` [Bug 77631] " bugzilla-daemon
2014-06-10 21:44 ` bugzilla-daemon
2014-06-10 21:49 ` bugzilla-daemon
2014-06-10 21:50 ` bugzilla-daemon

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.