search

pop-os / linux

Pop!_OS fork of https://launchpad.net/ubuntu/+source/linux
Other
110 stars 13 forks source link

Buggy USB device #151

Open curiousercreative opened 2 years ago

curiousercreative commented 2 years ago

Hello, apologies if this isn't the proper channel for report. This is a CFast2.0 USB3 card reader. These dmesg logs are when attempting to read and then I unmount/mount in there, it doesn't do that by itself. Without looking at dmesg, you'd just think the reader was extremely "bursty". It'll read at ~400MB/s for 10-15 seconds and then not respond for 30 seconds, but without a fixed cadence of how long it'll read for versus how long it'll hang for.

Hardware diagram: HP Z840 <=> GC-MAPLE RIDGE USB controller <=> Launch keyboard USB-C <=> Lexar card reader

$ uname -a
Linux shredder-curiouser 5.17.5-76051705-generic #202204271406~1653440576~22.04~6277a18 SMP PREEMPT Wed May 25 01 x86_64 x86_64 x86_64 GNU/Linux
$ cat /etc/os-release
NAME="Pop!_OS"
VERSION="22.04 LTS"
ID=pop
ID_LIKE="ubuntu debian"
PRETTY_NAME="Pop!_OS 22.04 LTS"
VERSION_ID="22.04"
HOME_URL="https://pop.system76.com"
SUPPORT_URL="https://support.system76.com"
BUG_REPORT_URL="https://github.com/pop-os/pop/issues"
PRIVACY_POLICY_URL="https://system76.com/privacy"
VERSION_CODENAME=jammy
UBUNTU_CODENAME=jammy
LOGO=distributor-logo-pop-os
$ sudo dmesg
[10338.920610] usb 6-1.2: USB disconnect, device number 3
[10370.078811] pcieport 0000:80:03.2: PME: Spurious native interrupt!
[10370.362433] usb 6-1.2: new SuperSpeed USB device number 4 using xhci_hcd
[10370.382941] usb 6-1.2: New USB device found, idVendor=05dc, idProduct=ba04, bcdDevice= 4.08
[10370.382945] usb 6-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
[10370.382947] usb 6-1.2: Product: WorkflowCR1
[10370.382949] usb 6-1.2: Manufacturer: Lexar
[10370.382950] usb 6-1.2: SerialNumber: 24060853500986
[10370.386180] scsi host5: uas
[10370.386862] scsi 5:0:0:0: Direct-Access     Lexar    WorkflowCR1      0    PQ: 0 ANSI: 6
[10370.387533] sd 5:0:0:0: Attached scsi generic sg7 type 0
[10370.387544] sd 5:0:0:0: [sdg] Media removed, stopped polling
[10370.388479] sd 5:0:0:0: [sdg] Attached SCSI removable disk
[10380.541072] sd 5:0:0:0: [sdg] 500137984 512-byte logical blocks: (256 GB/238 GiB)
[10380.541589] sdg: detected capacity change from 0 to 500137984
[10380.542194]  sdg: sdg1
[10380.705865] UDF-fs: INFO Mounting volume 'A005N1RJ', timestamp 2022/06/13 19:53 (1000)
[10392.975536] usb 6-1.2: cmd cmplt err -71
[10392.983746] usb 6-1.2: cmd cmplt err -71
[10394.844272] usb 6-1.2: cmd cmplt err -71
[10423.679969] sd 5:0:0:0: [sdg] tag#1 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[10423.679983] sd 5:0:0:0: [sdg] tag#1 CDB: Read(10) 28 00 00 06 dc 00 00 01 00 00
[10423.680088] sd 5:0:0:0: [sdg] tag#0 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN 
[10423.680091] sd 5:0:0:0: [sdg] tag#0 CDB: Read(10) 28 00 00 06 dd 00 00 02 00 00
[10424.863965] sd 5:0:0:0: [sdg] tag#5 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD 
[10424.863979] sd 5:0:0:0: [sdg] tag#5 CDB: Test Unit Ready 00 00 00 00 00 00
[10424.891955] scsi host5: uas_eh_device_reset_handler start
[10424.972393] usb 6-1.2: reset SuperSpeed USB device number 4 using xhci_hcd
[10424.993715] scsi host5: uas_eh_device_reset_handler success
[10428.822862] usb 6-1.2: cmd cmplt err -71
[10428.822981] usb 6-1.2: cmd cmplt err -71
[10429.011880] usb 6-1.2: cmd cmplt err -71
[10460.542349] sd 5:0:0:0: [sdg] tag#9 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD 
[10460.542362] sd 5:0:0:0: [sdg] tag#9 CDB: Test Unit Ready 00 00 00 00 00 00
[10460.542369] sd 5:0:0:0: [sdg] tag#7 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[10460.542373] sd 5:0:0:0: [sdg] tag#7 CDB: Read(10) 28 00 00 35 28 00 00 04 00 00
[10460.542531] sd 5:0:0:0: [sdg] tag#6 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN 
[10460.542539] sd 5:0:0:0: [sdg] tag#6 CDB: Read(10) 28 00 00 35 24 00 00 04 00 00
[10460.574355] scsi host5: uas_eh_device_reset_handler start
[10460.654686] usb 6-1.2: reset SuperSpeed USB device number 4 using xhci_hcd
[10460.680083] scsi host5: uas_eh_device_reset_handler success
[10481.017104] usb 6-1.2: cmd cmplt err -71
[10481.024570] usb 6-1.2: cmd cmplt err -71
[10482.872118] usb 6-1.2: cmd cmplt err -71
[10511.740001] sd 5:0:0:0: [sdg] tag#3 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[10511.740010] sd 5:0:0:0: [sdg] tag#3 CDB: Read(10) 28 00 01 2a 8b 00 00 02 00 00
[10511.740155] sd 5:0:0:0: [sdg] tag#2 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN 
[10511.740159] sd 5:0:0:0: [sdg] tag#2 CDB: Read(10) 28 00 01 2a 8a 00 00 01 00 00
[10512.891970] sd 5:0:0:0: [sdg] tag#0 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD 
[10512.891981] sd 5:0:0:0: [sdg] tag#0 CDB: Test Unit Ready 00 00 00 00 00 00
[10512.907987] scsi host5: uas_eh_device_reset_handler start
[10512.988385] usb 6-1.2: reset SuperSpeed USB device number 4 using xhci_hcd
[10513.009699] scsi host5: uas_eh_device_reset_handler success
[10513.365783] usb 6-1.2: cmd cmplt err -71
[10513.373067] usb 6-1.2: cmd cmplt err -71
[10515.030622] usb 6-1.2: cmd cmplt err -71
[10544.506547] sd 5:0:0:0: [sdg] tag#11 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[10544.506560] sd 5:0:0:0: [sdg] tag#11 CDB: Read(10) 28 00 01 2e c5 00 00 04 00 00
[10544.506712] sd 5:0:0:0: [sdg] tag#10 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN 
[10544.506720] sd 5:0:0:0: [sdg] tag#10 CDB: Read(10) 28 00 01 2e c9 00 00 03 00 00
[10545.050532] sd 5:0:0:0: [sdg] tag#13 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD 
[10545.050539] sd 5:0:0:0: [sdg] tag#13 CDB: Test Unit Ready 00 00 00 00 00 00
[10545.082543] scsi host5: uas_eh_device_reset_handler start
[10545.162906] usb 6-1.2: reset SuperSpeed USB device number 4 using xhci_hcd
[10545.188093] scsi host5: uas_eh_device_reset_handler success
[10557.536970] usb 6-1.2: cmd cmplt err -71
[10557.543745] usb 6-1.2: cmd cmplt err -71
[10559.316807] usb 6-1.2: cmd cmplt err -71
[10589.560454] sd 5:0:0:0: [sdg] tag#12 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD 
[10589.560465] sd 5:0:0:0: [sdg] tag#12 CDB: Test Unit Ready 00 00 00 00 00 00
[10589.560469] sd 5:0:0:0: [sdg] tag#11 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[10589.560472] sd 5:0:0:0: [sdg] tag#11 CDB: Read(10) 28 00 01 c7 65 00 00 04 00 00
[10589.560541] sd 5:0:0:0: [sdg] tag#10 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN 
[10589.560544] sd 5:0:0:0: [sdg] tag#10 CDB: Read(10) 28 00 01 c7 69 00 00 03 00 00
[10589.588473] scsi host5: uas_eh_device_reset_handler start
[10589.672718] usb 6-1.2: reset SuperSpeed USB device number 4 using xhci_hcd
[10589.693820] scsi host5: uas_eh_device_reset_handler success
[10590.706950] usb 6-1.2: cmd cmplt err -71
[10590.714764] usb 6-1.2: cmd cmplt err -71
[10591.731237] usb 6-1.2: cmd cmplt err -71
[10622.327035] sd 5:0:0:0: [sdg] tag#9 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[10622.327048] sd 5:0:0:0: [sdg] tag#9 CDB: Read(10) 28 00 01 d4 34 00 00 01 00 00
[10622.327157] sd 5:0:0:0: [sdg] tag#8 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN 
[10622.327159] sd 5:0:0:0: [sdg] tag#8 CDB: Read(10) 28 00 01 d4 35 00 00 02 00 00
[10622.327289] sd 5:0:0:0: [sdg] tag#4 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD 
[10622.327293] sd 5:0:0:0: [sdg] tag#4 CDB: Test Unit Ready 00 00 00 00 00 00
[10622.342954] scsi host5: uas_eh_device_reset_handler start
[10622.427295] usb 6-1.2: reset SuperSpeed USB device number 4 using xhci_hcd
[10622.448564] scsi host5: uas_eh_device_reset_handler success
[10654.332784] usb 6-1.2: cmd cmplt err -71
[10654.339733] usb 6-1.2: cmd cmplt err -71
[10654.708276] usb 6-1.2: cmd cmplt err -71
[10661.987377] usb 6-1.2: cmd cmplt err -71
leviport commented 2 years ago

Have you narrowed this down to being an issue on Pop specifically? It sounds like it might just be a buggy device.

curiousercreative commented 2 years ago

@leviport it's almost certainly not Pop! specific. I imagine it's Linux generic and like you said, probably a quirky device. it's a fairly common card reader in professional film production and photography and it works properly on macOS 10.14 & 12 (probably works on Windows too). I opened this issue here because I read that's the first step for Linux kernel bug reports. Unfortunately, it's not a card reader I own (my partner had it on rental), so I cannot really try on different USB controllers and host systems. I'll add hardware details to original post though