UAS gadget driver & UAS host driver [was: Re: [RFC/PATCH 0/4] UASP device driver]

["Tanya Brokhman" <tlinder@codeaurora.org>]

[-- Attachment #1: Type: text/plain, Size: 1879 bytes --]

Hello Sarah, Matthew

We're almost done with our internal testing (using the MSDVT tool we
purchased from MCCI and the UT we developed) so our main concentration right
now is on the UAS host which isn't working for us very well.

Attached is the dmesg snippet from the UAS host. (I've added a few dbg
printk while debugging)
The SCSI command sequence that occurs after enumeration is INQUERY, TEST
UNIT READY, READ CAPACITY, MODE SENSE. The first 3 finish correctly but
after issuing MODE SENSE command I observe 2 strange warnings:

[ 4335.771653] xhci_hcd 0000:01:00.0: WARN: babble error on endpoint
[ 4335.771657] usb 9-1: ep 0x81 - asked for 4 bytes, 4 bytes untransferred
[ 4335.771771] xhci_hcd 0000:01:00.0: WARN Set TR Deq Ptr cmd invalid
because of stream ID configuration

After that the scsi error handling mechanism takes over and tries to reset
the device, which fails since TM aren't implemented yet. 

I've tried to figure out what these warning mean but got lost in the code.
The LECroy log or device side dmesg didn't show any errors nor anything
suspicions at all.

Do you know what this warning mean? My guess was that streams handling is
wrong in our DCD but all of MSDVT (MCCI tool) tests passed and streams are
used there as well, also in parallel execution.

Another thing I've noticed in the code is that all the IUs are issued with
stream_id = 1. This is set in uas_queuecommand_lck() (from uas.c) since
blk_rq_tagged(cmnd->request) == FALSE. The latest condition would be true if
REQ_QUEUED flag would be turned on in request->cmd_flags. I found no
reference of this flag usage at all so all the commands right now are issued
with stream_id=1. Is there a reason behind this?

Thank you for your assistance!

Best regards,
Tanya Brokhman
Consultant for Qualcomm Innovation Center, Inc.
Qualcomm Innovation Center, Inc. is a member of Code Aurora Forum


[-- Attachment #2: mesg_lab_uas.txt --]
[-- Type: text/plain, Size: 23765 bytes --]

[ 4335.730025] hub 9-0:1.0: port 1, status 8103, change 0000, 5.0 Gb/s
[ 4335.730269] usb 9-1: new SuperSpeed USB device using xhci_hcd and address 2
[ 4335.751976] usb 9-1: skipped 2 descriptors after endpoint
[ 4335.751979] usb 9-1: skipped 2 descriptors after endpoint
[ 4335.751981] usb 9-1: skipped 2 descriptors after endpoint
[ 4335.751984] usb 9-1: skipped 2 descriptors after endpoint
[ 4335.752217] xhci_hcd 0000:01:00.0: WARN: short transfer on control ep
[ 4335.752471] usb 9-1: default language 0x0409
[ 4335.752715] xhci_hcd 0000:01:00.0: WARN: short transfer on control ep
[ 4335.753215] xhci_hcd 0000:01:00.0: WARN: short transfer on control ep
[ 4335.753470] usb 9-1: udev 2, busnum 9, minor = 1025
[ 4335.753472] usb 9-1: New USB device found, idVendor=0525, idProduct=a4a5
[ 4335.753475] usb 9-1: New USB device strings: Mfr=2, Product=3, SerialNumber=0
[ 4335.753477] usb 9-1: Product: Mass Storage Gadget
[ 4335.753479] usb 9-1: Manufacturer: Linux 2.6.37+ with pcd
[ 4335.753575] usb 9-1: usb_probe_device
[ 4335.753578] usb 9-1: configuration #1 chosen from 1 choice
[ 4335.753585] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4335.753589] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4335.753593] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4335.753598] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4335.753941] usb 9-1: Successful Endpoint Configure command
[ 4335.762475] usb 9-1: adding 9-1:1.0 (config #1, interface 0)
[ 4335.762513] libusual 9-1:1.0: usb_probe_interface
[ 4335.762516] libusual 9-1:1.0: usb_probe_interface - got id
[ 4335.762544] uas 9-1:1.0: usb_probe_interface
[ 4335.762546] uas 9-1:1.0: usb_probe_interface - got id
[ 4335.762575] scsi9 : uas
[ 4335.762634] uas_configure_endpoints(): cmd_ep_addrs = 02, status_ep_addr = 82
[ 4335.762636] ,		data_in_addr= 81, data_out_addr= 01
[ 4335.763496] usb 9-1: Successful Endpoint Configure command
[ 4335.763500] uas_configure_endpoints(): devinfo->qdepth = 1f,
[ 4335.763653] uas_queuecommand_lck(cmnd[0]=12): cmndinfo->stream = 1
[ 4335.763656] uas_submit_urbs(): cmnd[0] = 12, stream_id = 0001
[ 4335.763663] usb 9-1: ep 0x82 - urb len = 0x70 (112), addr = 0x37af8800, num_trbs = 1
[ 4335.763669] usb 9-1: ep 0x81 - urb len = 36, sglist used, num_trbs = 1
[ 4335.763675] usb 9-1: ep 0x2 - urb len = 0x20 (32), addr = 0xbd6c73c0, num_trbs = 1
[ 4335.763698] usb 9-1: ep 0x2 - asked for 32 bytes, 0 bytes untransferred
[ 4335.763882] usb 9-1: ep 0x81 - asked for 36 bytes, 0 bytes untransferred
[ 4335.763992] usb 9-1: ep 0x82 - asked for 112 bytes, 0 bytes untransferred
[ 4335.763997] scsi 9:0:0:0: uas_sense: urb length 112 disagrees with IU sense data length 5, using 5 bytes of sense data
[ 4335.764024] scsi 9:0:0:0: Direct-Access     Linux    File-CD Gadget   0399 PQ: 0 ANSI: 2
[ 4335.764069] uas_queuecommand_lck(cmnd[0]=12): cmndinfo->stream = 1
[ 4335.764072] uas_submit_urbs(): cmnd[0] = 12, stream_id = 0002
[ 4335.764077] usb 9-1: ep 0x82 - urb len = 0x70 (112), addr = 0x379cc880, num_trbs = 1
[ 4335.764082] usb 9-1: ep 0x81 - urb len = 36, sglist used, num_trbs = 1
[ 4335.764088] usb 9-1: ep 0x2 - urb len = 0x20 (32), addr = 0xc3f197c0, num_trbs = 1
[ 4335.764100] usb 9-1: ep 0x2 - asked for 32 bytes, 0 bytes untransferred
[ 4335.764261] usb 9-1: ep 0x81 - asked for 36 bytes, 0 bytes untransferred
[ 4335.764395] usb 9-1: ep 0x82 - asked for 112 bytes, 0 bytes untransferred
[ 4335.764399] scsi 9:0:0:1: uas_sense: urb length 112 disagrees with IU sense data length 5, using 5 bytes of sense data
[ 4335.764709] sd 9:0:0:0: Attached scsi generic sg2 type 0
[ 4335.764788] uas_queuecommand_lck(cmnd[0]=00): cmndinfo->stream = 1
[ 4335.764791] uas_submit_urbs(): cmnd[0] = 00, stream_id = 0003
[ 4335.764796] usb 9-1: ep 0x82 - urb len = 0x70 (112), addr = 0x123079b80, num_trbs = 1
[ 4335.764802] usb 9-1: ep 0x2 - urb len = 0x20 (32), addr = 0xc3f19a40, num_trbs = 1
[ 4335.764817] usb 9-1: ep 0x2 - asked for 32 bytes, 0 bytes untransferred
[ 4335.765000] usb 9-1: ep 0x82 - asked for 112 bytes, 0 bytes untransferred
[ 4335.765005] sd 9:0:0:0: uas_sense: urb length 112 disagrees with IU sense data length 5, using 5 bytes of sense data
[ 4335.765014] usb usb8: usb auto-resume
[ 4335.765018] usb usb8: wakeup_rh
[ 4335.770841] uas_queuecommand_lck(cmnd[0]=25): cmndinfo->stream = 1
[ 4335.770845] uas_submit_urbs(): cmnd[0] = 25, stream_id = 0004
[ 4335.770855] usb 9-1: ep 0x82 - urb len = 0x70 (112), addr = 0x37af8a80, num_trbs = 1
[ 4335.770863] usb 9-1: ep 0x81 - urb len = 8, sglist used, num_trbs = 1
[ 4335.770870] usb 9-1: ep 0x2 - urb len = 0x20 (32), addr = 0xbd6c7320, num_trbs = 1
[ 4335.770886] usb 9-1: ep 0x2 - asked for 32 bytes, 0 bytes untransferred
[ 4335.771140] usb 9-1: ep 0x81 - asked for 8 bytes, 0 bytes untransferred
[ 4335.771257] usb 9-1: ep 0x82 - asked for 112 bytes, 0 bytes untransferred
[ 4335.771262] sd 9:0:0:0: uas_sense: urb length 112 disagrees with IU sense data length 5, using 5 bytes of sense data
[ 4335.771365] sd 9:0:0:0: [sdb] 1953 512-byte logical blocks: (999 kB/976 KiB)
[ 4335.771373] uas_queuecommand_lck(cmnd[0]=1a): cmndinfo->stream = 1
[ 4335.771375] uas_submit_urbs(): cmnd[0] = 1a, stream_id = 0005
[ 4335.771380] usb 9-1: ep 0x82 - urb len = 0x70 (112), addr = 0x37af8a80, num_trbs = 1
[ 4335.771386] usb 9-1: ep 0x81 - urb len = 4, sglist used, num_trbs = 1
[ 4335.771391] usb 9-1: ep 0x2 - urb len = 0x20 (32), addr = 0xbd6c7320, num_trbs = 1
[ 4335.771406] usb 9-1: ep 0x2 - asked for 32 bytes, 0 bytes untransferred


[ 4335.771653] xhci_hcd 0000:01:00.0: WARN: babble error on endpoint
[ 4335.771657] usb 9-1: ep 0x81 - asked for 4 bytes, 4 bytes untransferred
[ 4335.771771] xhci_hcd 0000:01:00.0: WARN Set TR Deq Ptr cmd invalid because of stream ID configuration


[ 4335.810017] hub 8-0:1.0: hub_resume
[ 4335.810088] usb usb7: usb auto-resume
[ 4335.810090] usb usb7: wakeup_rh
[ 4335.810106] hub 8-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4335.860010] hub 7-0:1.0: hub_resume
[ 4335.860029] hub 7-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4335.860069] usb usb6: usb auto-resume
[ 4335.860072] usb usb6: wakeup_rh
[ 4335.910014] hub 6-0:1.0: hub_resume
[ 4335.910031] hub 6-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4335.910062] usb usb5: usb auto-resume
[ 4335.910065] usb usb5: wakeup_rh
[ 4335.960011] hub 5-0:1.0: hub_resume
[ 4335.960027] hub 5-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4335.960147] usb usb3: usb auto-resume
[ 4335.960150] usb usb3: wakeup_rh
[ 4336.010014] hub 3-0:1.0: hub_resume
[ 4336.010029] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4336.010062] usb usb2: usb auto-resume
[ 4336.010066] ehci_hcd 0000:00:1d.7: resume root hub
[ 4336.050012] hub 2-0:1.0: hub_resume
[ 4336.050034] hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4336.050060] usb usb1: usb auto-resume
[ 4336.050064] ehci_hcd 0000:00:1a.7: resume root hub
[ 4336.120012] hub 1-0:1.0: hub_resume
[ 4336.120034] hub 1-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4337.040024] usb usb8: suspend_rh (auto-stop)
[ 4337.040044] usb usb7: suspend_rh (auto-stop)
[ 4337.040062] usb usb6: suspend_rh (auto-stop)
[ 4337.040079] usb usb5: suspend_rh (auto-stop)
[ 4337.040097] usb usb3: suspend_rh (auto-stop)
[ 4338.488009] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4338.491006] hub 4-2:1.0: port 2, status 0100, change 0001, 12 Mb/s
[ 4338.491010] usb 4-2.2: USB disconnect, address 21
[ 4338.491012] usb 4-2.2: unregistering device
[ 4338.491014] usb 4-2.2: unregistering interface 4-2.2:1.0
[ 4338.491057] uhci_hcd 0000:00:1a.1: shutdown urb ffff8800bd614540 ep1in-intr
[ 4338.492003] uhci_hcd 0000:00:1a.1: release dev 21 ep81-INT, period 8, phase 4, 106 us
[ 4338.610130] usb 4-2.2: usb_disable_device nuking all URBs
[ 4338.772006] hub 4-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x100
[ 4339.020013] hub 8-0:1.0: hub_suspend
[ 4339.020023] usb usb8: bus auto-suspend
[ 4339.020025] usb usb8: suspend_rh
[ 4339.020040] hub 7-0:1.0: hub_suspend
[ 4339.020045] usb usb7: bus auto-suspend
[ 4339.020047] usb usb7: suspend_rh
[ 4339.020060] hub 6-0:1.0: hub_suspend
[ 4339.020065] usb usb6: bus auto-suspend
[ 4339.020067] usb usb6: suspend_rh
[ 4339.020081] hub 5-0:1.0: hub_suspend
[ 4339.020084] usb usb5: bus auto-suspend
[ 4339.020086] usb usb5: suspend_rh
[ 4339.020100] hub 3-0:1.0: hub_suspend
[ 4339.020103] usb usb3: bus auto-suspend
[ 4339.020106] usb usb3: suspend_rh
[ 4339.020119] hub 2-0:1.0: hub_suspend
[ 4339.020123] usb usb2: bus auto-suspend
[ 4339.020125] ehci_hcd 0000:00:1d.7: suspend root hub
[ 4339.020144] hub 1-0:1.0: hub_suspend
[ 4339.020148] usb usb1: bus auto-suspend
[ 4339.020150] ehci_hcd 0000:00:1a.7: suspend root hub
[ 4341.175970] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4341.178966] hub 4-2:1.0: port 2, status 0301, change 0001, 1.5 Mb/s
[ 4341.331966] hub 4-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x301
[ 4341.411966] usb 4-2.2: new low speed USB device using uhci_hcd and address 22
[ 4341.528962] usb 4-2.2: skipped 1 descriptor after interface
[ 4341.533958] usb 4-2.2: default language 0x0409
[ 4341.545961] usb 4-2.2: udev 22, busnum 4, minor = 405
[ 4341.545964] usb 4-2.2: New USB device found, idVendor=413c, idProduct=3016
[ 4341.545967] usb 4-2.2: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[ 4341.545970] usb 4-2.2: Product: Dell Premium USB Optical Mouse
[ 4341.546062] usb 4-2.2: usb_probe_device
[ 4341.546066] usb 4-2.2: configuration #1 chosen from 1 choice
[ 4341.548961] usb 4-2.2: adding 4-2.2:1.0 (config #1, interface 0)
[ 4341.549001] usbhid 4-2.2:1.0: usb_probe_interface
[ 4341.549003] usbhid 4-2.2:1.0: usb_probe_interface - got id
[ 4341.566266] input: Dell Premium USB Optical Mouse as /devices/pci0000:00/0000:00:1a.1/usb4/4-2/4-2.2/4-2.2:1.0/input/input22
[ 4341.566368] generic-usb 0003:413C:3016.0013: input,hidraw1: USB HID v1.11 Mouse [Dell Premium USB Optical Mouse] on usb-0000:00:1a.1-2.2/input0
[ 4341.566411] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4341.567893] usb usb8: usb auto-resume
[ 4341.567897] usb usb8: wakeup_rh
[ 4341.610014] hub 8-0:1.0: hub_resume
[ 4341.610037] uhci_hcd 0000:00:1a.1: reserve dev 22 ep81-INT, period 8, phase 4, 106 us
[ 4341.610090] usb usb7: usb auto-resume
[ 4341.610093] usb usb7: wakeup_rh
[ 4341.610106] hub 8-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4341.660012] hub 7-0:1.0: hub_resume
[ 4341.660028] hub 7-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4341.660064] usb usb6: usb auto-resume
[ 4341.660067] usb usb6: wakeup_rh
[ 4341.710013] hub 6-0:1.0: hub_resume
[ 4341.710029] hub 6-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4341.710062] usb usb5: usb auto-resume
[ 4341.710065] usb usb5: wakeup_rh
[ 4341.760012] hub 5-0:1.0: hub_resume
[ 4341.760030] hub 5-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4341.760150] usb usb3: usb auto-resume
[ 4341.760153] usb usb3: wakeup_rh
[ 4341.810019] hub 3-0:1.0: hub_resume
[ 4341.810038] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4341.810084] usb usb2: usb auto-resume
[ 4341.810089] ehci_hcd 0000:00:1d.7: resume root hub
[ 4341.850010] hub 2-0:1.0: hub_resume
[ 4341.850032] hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4341.850060] usb usb1: usb auto-resume
[ 4341.850064] ehci_hcd 0000:00:1a.7: resume root hub
[ 4341.920013] hub 1-0:1.0: hub_resume
[ 4341.920034] hub 1-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4342.790015] usb usb8: suspend_rh (auto-stop)
[ 4342.790025] usb usb7: suspend_rh (auto-stop)
[ 4342.790044] usb usb6: suspend_rh (auto-stop)
[ 4342.790061] usb usb5: suspend_rh (auto-stop)
[ 4343.040019] usb usb3: suspend_rh (auto-stop)
[ 4344.010011] hub 8-0:1.0: hub_suspend
[ 4344.010017] usb usb8: bus auto-suspend
[ 4344.010020] usb usb8: suspend_rh
[ 4344.010033] hub 7-0:1.0: hub_suspend
[ 4344.010037] usb usb7: bus auto-suspend
[ 4344.010039] usb usb7: suspend_rh
[ 4344.010052] hub 6-0:1.0: hub_suspend
[ 4344.010055] usb usb6: bus auto-suspend
[ 4344.010057] usb usb6: suspend_rh
[ 4344.010070] hub 5-0:1.0: hub_suspend
[ 4344.010074] usb usb5: bus auto-suspend
[ 4344.010076] usb usb5: suspend_rh
[ 4344.010088] hub 3-0:1.0: hub_suspend
[ 4344.010091] usb usb3: bus auto-suspend
[ 4344.010093] usb usb3: suspend_rh
[ 4344.010106] hub 2-0:1.0: hub_suspend
[ 4344.010109] usb usb2: bus auto-suspend
[ 4344.010111] ehci_hcd 0000:00:1d.7: suspend root hub
[ 4344.010130] hub 1-0:1.0: hub_suspend
[ 4344.010133] usb usb1: bus auto-suspend
[ 4344.010135] ehci_hcd 0000:00:1a.7: suspend root hub
[ 4350.947808] usb 4-2.2: uhci_result_common: failed with status 440000
[ 4350.947816] uhci_hcd 0000:00:1a.1: release dev 22 ep81-INT, period 8, phase 4, 106 us
[ 4350.960009] uhci_hcd 0000:00:1a.1: reserve dev 22 ep81-INT, period 8, phase 4, 106 us
[ 4350.979807] usb 4-2.2: uhci_result_common: failed with status 440000
[ 4350.979813] uhci_hcd 0000:00:1a.1: release dev 22 ep81-INT, period 8, phase 4, 106 us
[ 4351.000008] uhci_hcd 0000:00:1a.1: reserve dev 22 ep81-INT, period 8, phase 4, 106 us
[ 4351.019806] usb 4-2.2: uhci_result_common: failed with status 440000
[ 4351.019811] uhci_hcd 0000:00:1a.1: release dev 22 ep81-INT, period 8, phase 4, 106 us
[ 4351.031814] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4351.034813] hub 4-2:1.0: port 2, status 0100, change 0001, 12 Mb/s
[ 4351.034816] usb 4-2.2: USB disconnect, address 22
[ 4351.034818] usb 4-2.2: unregistering device
[ 4351.034821] usb 4-2.2: unregistering interface 4-2.2:1.0
[ 4351.140126] usb 4-2.2: usb_disable_device nuking all URBs
[ 4351.301813] hub 4-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x100
[ 4358.583702] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4358.586693] hub 4-2:1.0: port 2, status 0301, change 0001, 1.5 Mb/s
[ 4358.741693] hub 4-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x301
[ 4358.821695] usb 4-2.2: new low speed USB device using uhci_hcd and address 23
[ 4358.938689] usb 4-2.2: skipped 1 descriptor after interface
[ 4358.943689] usb 4-2.2: default language 0x0409
[ 4358.955690] usb 4-2.2: udev 23, busnum 4, minor = 406
[ 4358.955693] usb 4-2.2: New USB device found, idVendor=413c, idProduct=3016
[ 4358.955696] usb 4-2.2: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[ 4358.955698] usb 4-2.2: Product: Dell Premium USB Optical Mouse
[ 4358.955792] usb 4-2.2: usb_probe_device
[ 4358.955796] usb 4-2.2: configuration #1 chosen from 1 choice
[ 4358.958690] usb 4-2.2: adding 4-2.2:1.0 (config #1, interface 0)
[ 4358.958729] usbhid 4-2.2:1.0: usb_probe_interface
[ 4358.958732] usbhid 4-2.2:1.0: usb_probe_interface - got id
[ 4358.975997] input: Dell Premium USB Optical Mouse as /devices/pci0000:00/0000:00:1a.1/usb4/4-2/4-2.2/4-2.2:1.0/input/input23
[ 4358.976099] generic-usb 0003:413C:3016.0014: input,hidraw1: USB HID v1.11 Mouse [Dell Premium USB Optical Mouse] on usb-0000:00:1a.1-2.2/input0
[ 4358.977654] usb usb8: usb auto-resume
[ 4358.977657] usb usb8: wakeup_rh
[ 4359.020030] uhci_hcd 0000:00:1a.1: reserve dev 23 ep81-INT, period 8, phase 4, 106 us
[ 4359.020036] hub 8-0:1.0: hub_resume
[ 4359.020109] usb usb7: usb auto-resume
[ 4359.020113] usb usb7: wakeup_rh
[ 4359.020125] hub 8-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4359.070013] hub 7-0:1.0: hub_resume
[ 4359.070031] hub 7-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4359.070064] usb usb6: usb auto-resume
[ 4359.070067] usb usb6: wakeup_rh
[ 4359.120014] hub 6-0:1.0: hub_resume
[ 4359.120029] hub 6-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4359.120063] usb usb5: usb auto-resume
[ 4359.120066] usb usb5: wakeup_rh
[ 4359.170011] hub 5-0:1.0: hub_resume
[ 4359.170028] hub 5-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4359.170147] usb usb3: usb auto-resume
[ 4359.170150] usb usb3: wakeup_rh
[ 4359.220014] hub 3-0:1.0: hub_resume
[ 4359.220028] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4359.220061] usb usb2: usb auto-resume
[ 4359.220065] ehci_hcd 0000:00:1d.7: resume root hub
[ 4359.260012] hub 2-0:1.0: hub_resume
[ 4359.260033] hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4359.260062] usb usb1: usb auto-resume
[ 4359.260065] ehci_hcd 0000:00:1a.7: resume root hub
[ 4359.330012] hub 1-0:1.0: hub_resume
[ 4359.330035] hub 1-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4360.040023] usb usb8: suspend_rh (auto-stop)
[ 4360.290017] usb usb7: suspend_rh (auto-stop)
[ 4360.290035] usb usb6: suspend_rh (auto-stop)
[ 4360.290053] usb usb5: suspend_rh (auto-stop)
[ 4360.290070] usb usb3: suspend_rh (auto-stop)
[ 4362.020014] hub 8-0:1.0: hub_suspend
[ 4362.020022] usb usb8: bus auto-suspend
[ 4362.020024] usb usb8: suspend_rh
[ 4362.020038] hub 7-0:1.0: hub_suspend
[ 4362.020042] usb usb7: bus auto-suspend
[ 4362.020044] usb usb7: suspend_rh
[ 4362.020057] hub 6-0:1.0: hub_suspend
[ 4362.020060] usb usb6: bus auto-suspend
[ 4362.020062] usb usb6: suspend_rh
[ 4362.020075] hub 5-0:1.0: hub_suspend
[ 4362.020079] usb usb5: bus auto-suspend
[ 4362.020081] usb usb5: suspend_rh
[ 4362.020094] hub 3-0:1.0: hub_suspend
[ 4362.020097] usb usb3: bus auto-suspend
[ 4362.020099] usb usb3: suspend_rh
[ 4362.020112] hub 2-0:1.0: hub_suspend
[ 4362.020116] usb usb2: bus auto-suspend
[ 4362.020118] ehci_hcd 0000:00:1d.7: suspend root hub
[ 4362.020137] hub 1-0:1.0: hub_suspend
[ 4362.020141] usb usb1: bus auto-suspend
[ 4362.020143] ehci_hcd 0000:00:1a.7: suspend root hub
[ 4366.060012] sd 9:0:0:0: uas_eh_abort_handler tag -1
[ 4366.060018] sd 9:0:0:0: uas_eh_device_reset_handler tag -1
[ 4366.060021] sd 9:0:0:0: uas_eh_target_reset_handler tag -1
[ 4366.060023] sd 9:0:0:0: uas_eh_bus_reset_handler tag -1
[ 4366.180966] usb 9-1: reset SuperSpeed USB device using xhci_hcd and address 2
[ 4366.201436] xhci_hcd 0000:01:00.0: xHCI xhci_drop_endpoint called with disabled ep ffff88011fd42640
[ 4366.201440] xhci_hcd 0000:01:00.0: xHCI xhci_drop_endpoint called with disabled ep ffff88011fd42600
[ 4366.201443] xhci_hcd 0000:01:00.0: xHCI xhci_drop_endpoint called with disabled ep ffff88011fd426c0
[ 4366.201446] xhci_hcd 0000:01:00.0: xHCI xhci_drop_endpoint called with disabled ep ffff88011fd42680
[ 4366.201452] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4366.201456] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4366.201463] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4366.201467] xhci_hcd 0000:01:00.0: WARN no SS endpoint bMaxBurst
[ 4366.201804] usb 9-1: Successful Endpoint Configure command
[ 4366.216188] xhci_hcd 0000:01:00.0: shutdown urb ffff880121153d80 ep2in-bulk
[ 4366.216326] usb 9-1: URB BAD STATUS -108
[ 4366.216337] sd 9:0:0:0: Device offlined - not ready after error recovery
[ 4366.216348] sd 9:0:0:0: [sdb] Write Protect is off
[ 4366.216351] sd 9:0:0:0: [sdb] Mode Sense: 00 00 00 00
[ 4366.216356] sd 9:0:0:0: rejecting I/O to offline device
[ 4366.216361] sd 9:0:0:0: [sdb] Asking for cache data failed
[ 4366.216363] sd 9:0:0:0: [sdb] Assuming drive cache: write through
[ 4366.216505] sd 9:0:0:0: [sdb] Attached SCSI removable disk
[ 4378.039384] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4378.042381] hub 4-2:1.0: port 2, status 0100, change 0001, 12 Mb/s
[ 4378.042385] usb 4-2.2: USB disconnect, address 23
[ 4378.042388] usb 4-2.2: unregistering device
[ 4378.042390] usb 4-2.2: unregistering interface 4-2.2:1.0
[ 4378.042432] uhci_hcd 0000:00:1a.1: shutdown urb ffff8800c3f7fd80 ep1in-intr
[ 4378.043375] usb 4-2.2: uhci_result_common: failed with status 440000
[ 4378.043381] uhci_hcd 0000:00:1a.1: release dev 23 ep81-INT, period 8, phase 4, 106 us
[ 4378.150127] usb 4-2.2: usb_disable_device nuking all URBs
[ 4378.311380] hub 4-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x100
[ 4486.837494] hub 4-2:1.0: state 7 ports 4 chg 0000 evt 0004
[ 4486.840486] hub 4-2:1.0: port 2, status 0301, change 0001, 1.5 Mb/s
[ 4487.001485] hub 4-2:1.0: debounce: port 2: total 100ms stable 100ms status 0x301
[ 4487.081483] usb 4-2.2: new low speed USB device using uhci_hcd and address 24
[ 4487.198482] usb 4-2.2: skipped 1 descriptor after interface
[ 4487.203480] usb 4-2.2: default language 0x0409
[ 4487.215481] usb 4-2.2: udev 24, busnum 4, minor = 407
[ 4487.215484] usb 4-2.2: New USB device found, idVendor=413c, idProduct=3016
[ 4487.215487] usb 4-2.2: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[ 4487.215489] usb 4-2.2: Product: Dell Premium USB Optical Mouse
[ 4487.215585] usb 4-2.2: usb_probe_device
[ 4487.215589] usb 4-2.2: configuration #1 chosen from 1 choice
[ 4487.218481] usb 4-2.2: adding 4-2.2:1.0 (config #1, interface 0)
[ 4487.218521] usbhid 4-2.2:1.0: usb_probe_interface
[ 4487.218524] usbhid 4-2.2:1.0: usb_probe_interface - got id
[ 4487.235783] input: Dell Premium USB Optical Mouse as /devices/pci0000:00/0000:00:1a.1/usb4/4-2/4-2.2/4-2.2:1.0/input/input24
[ 4487.235887] generic-usb 0003:413C:3016.0015: input,hidraw1: USB HID v1.11 Mouse [Dell Premium USB Optical Mouse] on usb-0000:00:1a.1-2.2/input0
[ 4487.237423] usb usb8: usb auto-resume
[ 4487.237427] usb usb8: wakeup_rh
[ 4487.260288] uhci_hcd 0000:00:1a.1: reserve dev 24 ep81-INT, period 8, phase 4, 106 us
[ 4487.280015] hub 8-0:1.0: hub_resume
[ 4487.280035] hub 8-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4487.280090] usb usb7: usb auto-resume
[ 4487.280093] usb usb7: wakeup_rh
[ 4487.330012] hub 7-0:1.0: hub_resume
[ 4487.330027] hub 7-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4487.330061] usb usb6: usb auto-resume
[ 4487.330064] usb usb6: wakeup_rh
[ 4487.380012] hub 6-0:1.0: hub_resume
[ 4487.380029] hub 6-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4487.380059] usb usb5: usb auto-resume
[ 4487.380062] usb usb5: wakeup_rh
[ 4487.430011] hub 5-0:1.0: hub_resume
[ 4487.430028] hub 5-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4487.430145] usb usb3: usb auto-resume
[ 4487.430148] usb usb3: wakeup_rh
[ 4487.480010] hub 3-0:1.0: hub_resume
[ 4487.480026] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 4487.480055] usb usb2: usb auto-resume
[ 4487.480059] ehci_hcd 0000:00:1d.7: resume root hub
[ 4487.520010] hub 2-0:1.0: hub_resume
[ 4487.520033] hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4487.520062] usb usb1: usb auto-resume
[ 4487.520065] ehci_hcd 0000:00:1a.7: resume root hub
[ 4487.590010] hub 1-0:1.0: hub_resume
[ 4487.590031] hub 1-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 4488.290029] usb usb8: suspend_rh (auto-stop)
[ 4488.540015] usb usb7: suspend_rh (auto-stop)
[ 4488.540023] usb usb6: suspend_rh (auto-stop)
[ 4488.540041] usb usb5: suspend_rh (auto-stop)
[ 4488.540059] usb usb3: suspend_rh (auto-stop)
[ 4490.010012] hub 8-0:1.0: hub_suspend
[ 4490.010020] usb usb8: bus auto-suspend
[ 4490.010022] usb usb8: suspend_rh
[ 4490.010036] hub 7-0:1.0: hub_suspend
[ 4490.010041] usb usb7: bus auto-suspend
[ 4490.010043] usb usb7: suspend_rh
[ 4490.010056] hub 6-0:1.0: hub_suspend
[ 4490.010059] usb usb6: bus auto-suspend
[ 4490.010061] usb usb6: suspend_rh
[ 4490.010074] hub 5-0:1.0: hub_suspend
[ 4490.010078] usb usb5: bus auto-suspend
[ 4490.010080] usb usb5: suspend_rh
[ 4490.010093] hub 3-0:1.0: hub_suspend
[ 4490.010096] usb usb3: bus auto-suspend
[ 4490.010098] usb usb3: suspend_rh
[ 4490.010111] hub 2-0:1.0: hub_suspend
[ 4490.010115] usb usb2: bus auto-suspend
[ 4490.010118] ehci_hcd 0000:00:1d.7: suspend root hub
[ 4490.010136] hub 1-0:1.0: hub_suspend
[ 4490.010140] usb usb1: bus auto-suspend
[ 4490.010142] ehci_hcd 0000:00:1a.7: suspend root hub