External USB 3 HDD fails to transfer files on Linux

Operating Systems & Open Source Linux
, ,
1

I recently built a new machine

  • Gigabyte Aorus X570i
  • AMD Ryzen 7 3700X
  • AMD Radeon 5700 XT
  • Manjaro GNOME (latest)
  • Linux Kernel 5.5

and I found out that file transfers fail when reading/writing large amounts of data.

I have a log from dmesg:

[ 7208.678740] audit: type=1130 audit(1580686010.900:131): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[ 7218.807647] audit: type=1131 audit(1580686021.027:132): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[ 7363.414814] audit: type=1130 audit(1580686165.640:133): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[ 7399.048763] audit: type=1131 audit(1580686201.274:134): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[ 7578.732385] sd 17:0:0:0: [sdd] tag#4 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD OUT 
[ 7578.732389] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7578.765714] scsi host17: uas_eh_device_reset_handler start
[ 7578.842594] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7578.863854] scsi host17: uas_eh_device_reset_handler success
[ 7609.491625] scsi host17: uas_eh_device_reset_handler start
[ 7609.491714] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7609.491717] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7609.565110] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7609.586419] scsi host17: uas_eh_device_reset_handler success
[ 7640.180767] scsi host17: uas_eh_device_reset_handler start
[ 7640.180822] sd 17:0:0:0: [sdd] tag#0 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7640.180827] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7640.254383] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7640.275686] scsi host17: uas_eh_device_reset_handler success
[ 7670.927489] scsi host17: uas_eh_device_reset_handler start
[ 7670.927543] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7670.927545] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7671.000280] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7671.021574] scsi host17: uas_eh_device_reset_handler success
[ 7701.625999] scsi host17: uas_eh_device_reset_handler start
[ 7701.626060] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7701.626063] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7701.699553] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7701.720803] scsi host17: uas_eh_device_reset_handler success
[ 7732.345921] scsi host17: uas_eh_device_reset_handler start
[ 7732.345985] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7732.345988] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7732.418708] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7732.440018] scsi host17: uas_eh_device_reset_handler success
[ 7732.440105] sd 17:0:0:0: [sdd] tag#3 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=184s
[ 7732.440108] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
[ 7732.440110] blk_update_request: I/O error, dev sdd, sector 1548838912 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
[ 7740.848483] INFO: task (ostnamed):9746 blocked for more than 122 seconds.
[ 7740.848486]       Not tainted 5.5.0-1-MANJARO #1
[ 7740.848486] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 7740.848487] (ostnamed)      D    0  9746      1 0x00000084
[ 7740.848490] Call Trace:
[ 7740.848499]  ? __schedule+0x2e8/0x7a0
[ 7740.848502]  schedule+0x46/0xf0
[ 7740.848505]  rwsem_down_write_slowpath+0x2a2/0x530
[ 7740.848510]  do_mount+0x3ea/0xa30
[ 7740.848513]  ? syscall_trace_enter+0x19c/0x2e0
[ 7740.848515]  __x64_sys_mount+0x8e/0xd0
[ 7740.848517]  do_syscall_64+0x4e/0x150
[ 7740.848520]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
[ 7740.848523] RIP: 0033:0x7f0c5d473e4e
[ 7740.848527] Code: Bad RIP value.
[ 7740.848528] RSP: 002b:00007fff60e83378 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
[ 7740.848530] RAX: ffffffffffffffda RBX: 0000557fdc246630 RCX: 00007f0c5d473e4e
[ 7740.848530] RDX: 0000000000000000 RSI: 0000557fdc246630 RDI: 0000000000000000
[ 7740.848531] RBP: 0000557fdc222c78 R08: 0000000000000000 R09: 0000000000000007
[ 7740.848532] R10: 0000000000001027 R11: 0000000000000206 R12: 0000000000000001
[ 7740.848533] R13: 00007fff60e833e0 R14: 0000557fdc1b4620 R15: 0000557fdc225288
[ 7763.047802] sd 17:0:0:0: [sdd] tag#5 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD OUT 
[ 7763.047806] sd 17:0:0:0: [sdd] tag#5 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7763.047880] sd 17:0:0:0: [sdd] tag#4 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD OUT 
[ 7763.047884] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7763.047917] sd 17:0:0:0: [sdd] tag#3 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD 
[ 7763.047919] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7763.047928] sd 17:0:0:0: [sdd] tag#0 uas_eh_abort_handler 0 uas-tag 4 inflight: CMD OUT 
[ 7763.047929] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7763.071883] scsi host17: uas_eh_device_reset_handler start
[ 7763.144614] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7763.165918] scsi host17: uas_eh_device_reset_handler success
[ 7793.800377] scsi host17: uas_eh_device_reset_handler start
[ 7793.800607] sd 17:0:0:0: [sdd] tag#1 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7793.800610] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7793.800613] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 7793.800614] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7793.800616] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 7793.800618] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7793.800620] sd 17:0:0:0: [sdd] tag#4 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 7793.800621] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7793.873876] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7793.895167] scsi host17: uas_eh_device_reset_handler success
[ 7824.080402] scsi host17: uas_eh_device_reset_handler start
[ 7824.080666] sd 17:0:0:0: [sdd] tag#0 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7824.080670] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7824.080673] sd 17:0:0:0: [sdd] tag#1 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 7824.080675] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7824.080677] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 7824.080679] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7824.080681] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 7824.080683] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7824.153169] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7824.174407] scsi host17: uas_eh_device_reset_handler success
[ 7855.232203] scsi host17: uas_eh_device_reset_handler start
[ 7855.232426] sd 17:0:0:0: [sdd] tag#4 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7855.232429] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7855.232432] sd 17:0:0:0: [sdd] tag#0 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 7855.232433] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7855.232435] sd 17:0:0:0: [sdd] tag#1 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 7855.232437] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7855.232439] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 7855.232440] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7855.305684] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7855.327033] scsi host17: uas_eh_device_reset_handler success
[ 7863.725508] INFO: task kworker/u64:6:9002 blocked for more than 122 seconds.
[ 7863.725510]       Not tainted 5.5.0-1-MANJARO #1
[ 7863.725511] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 7863.725512] kworker/u64:6   D    0  9002      2 0x80004080
[ 7863.725519] Workqueue: writeback wb_workfn (flush-8:48)
[ 7863.725521] Call Trace:
[ 7863.725528]  ? __schedule+0x2e8/0x7a0
[ 7863.725530]  ? __wbt_done+0x30/0x30
[ 7863.725533]  ? __wbt_done+0x30/0x30
[ 7863.725534]  schedule+0x46/0xf0
[ 7863.725536]  io_schedule+0x12/0x40
[ 7863.725538]  rq_qos_wait+0x106/0x170
[ 7863.725540]  ? karma_partition+0x240/0x240
[ 7863.725542]  ? wbt_cleanup_cb+0x20/0x20
[ 7863.725544]  wbt_wait+0xa1/0xe0
[ 7863.725547]  __rq_qos_throttle+0x23/0x30
[ 7863.725549]  blk_mq_make_request+0x14b/0x670
[ 7863.725553]  generic_make_request+0xf2/0x350
[ 7863.725555]  submit_bio+0x6e/0x1e0
[ 7863.725574]  ext4_io_submit+0x49/0x60 [ext4]
[ 7863.725588]  ext4_writepages+0x7e1/0x1030 [ext4]
[ 7863.725591]  ? __wb_calc_thresh+0x130/0x130
[ 7863.725597]  ? do_writepages+0x1c/0x60
[ 7863.725599]  do_writepages+0x1c/0x60
[ 7863.725601]  __writeback_single_inode+0x3d/0x3d0
[ 7863.725603]  ? _raw_spin_lock+0x13/0x30
[ 7863.725605]  writeback_sb_inodes+0x1f0/0x430
[ 7863.725609]  __writeback_inodes_wb+0x4c/0xc0
[ 7863.725611]  wb_writeback+0x2b8/0x360
[ 7863.725614]  ? get_nr_inodes+0x32/0x50
[ 7863.725616]  wb_workfn+0x407/0x4e0
[ 7863.725618]  ? __switch_to_asm+0x40/0x70
[ 7863.725620]  ? __switch_to_asm+0x34/0x70
[ 7863.725621]  ? __switch_to_asm+0x40/0x70
[ 7863.725623]  ? __switch_to_asm+0x34/0x70
[ 7863.725624]  ? __switch_to_asm+0x40/0x70
[ 7863.725626]  ? __switch_to_asm+0x34/0x70
[ 7863.725627]  ? __switch_to_asm+0x40/0x70
[ 7863.725629]  ? __switch_to_asm+0x34/0x70
[ 7863.725633]  process_one_work+0x1e2/0x3b0
[ 7863.725635]  worker_thread+0x4a/0x3d0
[ 7863.725638]  kthread+0xfb/0x130
[ 7863.725639]  ? process_one_work+0x3b0/0x3b0
[ 7863.725640]  ? kthread_park+0x90/0x90
[ 7863.725642]  ret_from_fork+0x22/0x40
[ 7863.725646] INFO: task jbd2/sdd1-8:9039 blocked for more than 122 seconds.
[ 7863.725647]       Not tainted 5.5.0-1-MANJARO #1
[ 7863.725647] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 7863.725648] jbd2/sdd1-8     D    0  9039      2 0x80004080
[ 7863.725650] Call Trace:
[ 7863.725652]  ? __schedule+0x2e8/0x7a0
[ 7863.725654]  schedule+0x46/0xf0
[ 7863.725656]  io_schedule+0x12/0x40
[ 7863.725658]  wait_on_page_bit+0x139/0x230
[ 7863.725661]  ? file_fdatawait_range+0x20/0x20
[ 7863.725663]  __filemap_fdatawait_range+0x8b/0xe0
[ 7863.725667]  filemap_fdatawait_range_keep_errors+0xe/0x40
[ 7863.725673]  jbd2_journal_commit_transaction+0xb1d/0x19a0 [jbd2]
[ 7863.725675]  ? __switch_to_asm+0x40/0x70
[ 7863.725679]  ? wait_woken+0x70/0x70
[ 7863.725682]  ? try_to_del_timer_sync+0x57/0x80
[ 7863.725687]  kjournald2+0xe5/0x2b0 [jbd2]
[ 7863.725689]  ? wait_woken+0x70/0x70
[ 7863.725691]  kthread+0xfb/0x130
[ 7863.725695]  ? commit_timeout+0x10/0x10 [jbd2]
[ 7863.725696]  ? kthread_park+0x90/0x90
[ 7863.725698]  ret_from_fork+0x22/0x40
[ 7863.725705] INFO: task (ostnamed):9746 blocked for more than 245 seconds.
[ 7863.725706]       Not tainted 5.5.0-1-MANJARO #1
[ 7863.725706] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 7863.725707] (ostnamed)      D    0  9746      1 0x00000084
[ 7863.725708] Call Trace:
[ 7863.725710]  ? __schedule+0x2e8/0x7a0
[ 7863.725712]  schedule+0x46/0xf0
[ 7863.725714]  rwsem_down_write_slowpath+0x2a2/0x530
[ 7863.725718]  do_mount+0x3ea/0xa30
[ 7863.725721]  ? syscall_trace_enter+0x19c/0x2e0
[ 7863.725723]  __x64_sys_mount+0x8e/0xd0
[ 7863.725726]  do_syscall_64+0x4e/0x150
[ 7863.725728]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
[ 7863.725730] RIP: 0033:0x7f0c5d473e4e
[ 7863.725734] Code: Bad RIP value.
[ 7863.725734] RSP: 002b:00007fff60e83378 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
[ 7863.725736] RAX: ffffffffffffffda RBX: 0000557fdc246630 RCX: 00007f0c5d473e4e
[ 7863.725737] RDX: 0000000000000000 RSI: 0000557fdc246630 RDI: 0000000000000000
[ 7863.725737] RBP: 0000557fdc222c78 R08: 0000000000000000 R09: 0000000000000007
[ 7863.725738] R10: 0000000000001027 R11: 0000000000000206 R12: 0000000000000001
[ 7863.725739] R13: 00007fff60e833e0 R14: 0000557fdc1b4620 R15: 0000557fdc225288
[ 7885.951636] scsi host17: uas_eh_device_reset_handler start
[ 7885.951857] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7885.951860] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7885.951862] sd 17:0:0:0: [sdd] tag#4 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 7885.951864] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7885.951866] sd 17:0:0:0: [sdd] tag#0 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 7885.951867] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7885.951869] sd 17:0:0:0: [sdd] tag#1 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 7885.951871] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7886.885046] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7886.906629] scsi host17: uas_eh_device_reset_handler success
[ 7918.364112] scsi host17: uas_eh_device_reset_handler start
[ 7918.364386] sd 17:0:0:0: [sdd] tag#4 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7918.364390] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7918.364393] sd 17:0:0:0: [sdd] tag#0 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 7918.364395] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7918.364397] sd 17:0:0:0: [sdd] tag#1 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 7918.364399] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7918.364401] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 7918.364403] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7918.437458] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7918.458837] scsi host17: uas_eh_device_reset_handler success
[ 7918.458925] sd 17:0:0:0: [sdd] tag#0 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
[ 7918.458927] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
[ 7918.458930] blk_update_request: I/O error, dev sdd, sector 1548840960 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
[ 7918.458945] sd 17:0:0:0: [sdd] tag#1 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
[ 7918.458946] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
[ 7918.458948] blk_update_request: I/O error, dev sdd, sector 2927892744 op 0x1:(WRITE) flags 0x800 phys_seg 7 prio class 0
[ 7918.458957] sd 17:0:0:0: [sdd] tag#2 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
[ 7918.458958] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
[ 7918.458959] blk_update_request: I/O error, dev sdd, sector 1548839936 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
[ 7918.458966] sd 17:0:0:0: [sdd] tag#4 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
[ 7918.458968] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
[ 7918.458969] blk_update_request: I/O error, dev sdd, sector 1548841984 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
[ 7918.460386] audit: type=1130 audit(1580686720.697:135): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'
[ 7949.069851] sd 17:0:0:0: [sdd] tag#4 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD OUT 
[ 7949.069855] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 78 00 00 00 04 00 00 00
[ 7949.070118] sd 17:0:0:0: [sdd] tag#2 uas_eh_abort_handler 0 uas-tag 4 inflight: CMD OUT 
[ 7949.070122] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 84 00 00 00 04 00 00 00
[ 7949.070161] sd 17:0:0:0: [sdd] tag#1 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD OUT 
[ 7949.070163] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 5c 51 80 00 00 00 04 00 00 00
[ 7949.070192] sd 17:0:0:0: [sdd] tag#0 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD OUT 
[ 7949.070193] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 7c 00 00 00 04 00 00 00
[ 7949.085589] scsi host17: uas_eh_device_reset_handler start
[ 7949.156738] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7949.178172] scsi host17: uas_eh_device_reset_handler success
[ 7979.801418] scsi host17: uas_eh_device_reset_handler start
[ 7979.801646] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 7979.801649] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 78 00 00 00 04 00 00 00
[ 7979.801652] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 7979.801653] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 84 00 00 00 04 00 00 00
[ 7979.801655] sd 17:0:0:0: [sdd] tag#4 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 7979.801657] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 80 00 00 00 04 00 00 00
[ 7979.801659] sd 17:0:0:0: [sdd] tag#0 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 7979.801661] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 7c 00 00 00 04 00 00 00
[ 7979.872637] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 7979.894208] scsi host17: uas_eh_device_reset_handler success
[ 7986.602399] INFO: task jbd2/sdd1-8:9039 blocked for more than 245 seconds.
[ 7986.602401]       Not tainted 5.5.0-1-MANJARO #1
[ 7986.602402] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 7986.602403] jbd2/sdd1-8     D    0  9039      2 0x80004080
[ 7986.602406] Call Trace:
[ 7986.602414]  ? __schedule+0x2e8/0x7a0
[ 7986.602417]  schedule+0x46/0xf0
[ 7986.602418]  io_schedule+0x12/0x40
[ 7986.602422]  wait_on_page_bit+0x139/0x230
[ 7986.602424]  ? file_fdatawait_range+0x20/0x20
[ 7986.602427]  __filemap_fdatawait_range+0x8b/0xe0
[ 7986.602431]  filemap_fdatawait_range_keep_errors+0xe/0x40
[ 7986.602437]  jbd2_journal_commit_transaction+0xb1d/0x19a0 [jbd2]
[ 7986.602440]  ? __switch_to_asm+0x40/0x70
[ 7986.602444]  ? wait_woken+0x70/0x70
[ 7986.602447]  ? try_to_del_timer_sync+0x57/0x80
[ 7986.602452]  kjournald2+0xe5/0x2b0 [jbd2]
[ 7986.602454]  ? wait_woken+0x70/0x70
[ 7986.602457]  kthread+0xfb/0x130
[ 7986.602461]  ? commit_timeout+0x10/0x10 [jbd2]
[ 7986.602462]  ? kthread_park+0x90/0x90
[ 7986.602464]  ret_from_fork+0x22/0x40
[ 8010.521743] scsi host17: uas_eh_device_reset_handler start
[ 8010.521992] sd 17:0:0:0: [sdd] tag#1 uas_zap_pending 0 uas-tag 1 inflight: CMD 
[ 8010.521996] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 5c 51 7c 00 00 00 04 00 00 00
[ 8010.521998] sd 17:0:0:0: [sdd] tag#2 uas_zap_pending 0 uas-tag 2 inflight: CMD 
[ 8010.522000] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 78 00 00 00 04 00 00 00
[ 8010.522002] sd 17:0:0:0: [sdd] tag#3 uas_zap_pending 0 uas-tag 3 inflight: CMD 
[ 8010.522004] sd 17:0:0:0: [sdd] tag#3 CDB: Write(16) 8a 00 00 00 00 00 5c 51 84 00 00 00 04 00 00 00
[ 8010.522006] sd 17:0:0:0: [sdd] tag#4 uas_zap_pending 0 uas-tag 4 inflight: CMD 
[ 8010.522008] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 80 00 00 00 04 00 00 00
[ 8010.595294] usb 4-4.3: reset SuperSpeedPlus Gen 2 USB device number 11 using xhci_hcd
[ 8010.616757] scsi host17: uas_eh_device_reset_handler success

I did a bad sector check, but all my drives came up clean, and this happens for any external HDD I connect to my system.
I did a bit of research, and came up with an issue which links to https://unix.stackexchange.com/questions/239782/connection-problem-with-usb3-external-storage-on-linux-uas-driver-problem and https://ubuntuforums.org/showthread.php?t=2307662 where they say it is a problem with USB 3.x <-> SATA controllers and the linux kernel. I have also used 3 different drive enclosures, but all of them have the same problem.

In that linked issue they say the solution is the blacklist the uas driver in the kernel. After blacklisting the module, my system was unable to recognize any USB storage devices.

Another possible solution was to disable USB autosuspend power management (https://ubuntuforums.org/showthread.php?t=2307662), but that made things worse. Usually I could transfer a few files before speed would degrade and lock up the transfer, but after disabling the autosuspend, the file transfer immediately locked up.

I have tested this on Linux 5.4 and 5.5 kernels and the same issue still persists.

Interestingly I never had this problem on my older machine (i5-6600K) and I did connect via USB 3.1 Gen 1. I had zero problems and that was running on Linux 5.4 kernel.

I would greatly appreciate any insight on solving this issue.

2

I’ve seen wierd stuff with USB3 and SSDs under linux before (when USB3.0 was new).

I suspect that it may be/may have been a cabling problem that i only saw with SSD due to the higher speeds pushing USB3 speeds over the cable… (and maybe your HDD is faster than my older hard drives were - or your caddy is capable of faster USB3.x speeds and the cable(s) aren’t rated for said speeds).

So first step i’d be to try different (shorter/better shielded/etc.) USB cable(s).

3

Could be a cable issue.

Also check BIOS for USB Legacy support and see if it is turned on.
Also you want to set PnP (PlugnPlay) Aware OS to on if it exists.
Lastly, see if XCHI is turned off. If so, turn it on. If it is on, then turn it off. Not all vendors have a good implementation of this in the BIOS, sometimes the Linux kernel’s implementation is better because of quirks.

You never mentioned anything about firmware for your board. did you ever update that to something close to current?

4

I have tried different cables. One came with the enclosure, another one I bought from Amazon. Both are thick cables.

5

I have tried with different cables. Issue still occurs. I have also changed all combinations of Legacy USB, and XHCI handoff, nothing resolves the issue. PnP aware is not in the BIOS.
I am also using the latest BIOS F11 from 2019/12/09

6

Wow, that is rough. Are you using the ports on the back of the mobo or front panel?

7

Back of the motherboard, as I don’t have a case at the moment, and the new case I bought does not have any front IO.

I did check the manual and it says in the back there are only 3.1 Gen 1 and 2 ports. On the internal headers there are USB 3.1 Gen 1, and USB 2.0.

My old motherboard has 2.0 and 3.1 Gen 1 ports and I had no problems with that.

8

Don’t use Gen 2 ports. I’ve had nothing but trouble on the Gen 2 ports on Ryzen in Linux because the XHCI support is terrible.

My Gen 1 Avermedia ExtremeCap UVC runs into this exact issue on the Gen 2 ports, because the XHCI power management code sucks and the ASMedia chips used for the Ryzen platform just plain don’t work well at all on Linux.

9

@FurryJackman may be able to help you better here. I am still on AMD’s heavy machinery chips with USB 3,0 Gen 1 (FX-6300 on 990FX chipset.)

10

Unfortunately I only have Gen 1 and Gen 2 ports on the motherboard, and my ITX case has no front IO. I will try connecting a USB 2.0 hub to a 3.x port and maybe that will fix it but I am not hopeful

11

If possible, can we see

dmesg |grep xhc
&
grep -i xhci /boot/config-$(uname -r)

  1. Do you have IOMMU=soft in the bootloader? or are you even using IOMMU ?
12

Only use the Gen 1 ports. That’s how I got around the issue. They’re the blue ports, not the red ports. The internal 3.0 front panel header also goes to an ASMedia chip which has the same issue.

13 
sudo dmesg |grep xhc
[    3.391000] xhci_hcd 0000:05:00.1: xHCI Host Controller
[    3.391005] xhci_hcd 0000:05:00.1: new USB bus registered, assigned bus number 1
[    3.391188] xhci_hcd 0000:05:00.1: hcc params 0x0278ffe5 hci version 0x110 quirks 0x0000000000000410
[    3.391827] usb usb1: Manufacturer: Linux 5.5.2-1-MANJARO xhci-hcd
[    3.392130] xhci_hcd 0000:05:00.1: xHCI Host Controller
[    3.392132] xhci_hcd 0000:05:00.1: new USB bus registered, assigned bus number 2
[    3.392134] xhci_hcd 0000:05:00.1: Host supports USB 3.1 Enhanced SuperSpeed
[    3.392165] usb usb2: Manufacturer: Linux 5.5.2-1-MANJARO xhci-hcd
[    3.392438] xhci_hcd 0000:05:00.3: xHCI Host Controller
[    3.392441] xhci_hcd 0000:05:00.3: new USB bus registered, assigned bus number 3
[    3.392605] xhci_hcd 0000:05:00.3: hcc params 0x0278ffe5 hci version 0x110 quirks 0x0000000000000410
[    3.392862] usb usb3: Manufacturer: Linux 5.5.2-1-MANJARO xhci-hcd
[    3.393185] xhci_hcd 0000:05:00.3: xHCI Host Controller
[    3.393186] xhci_hcd 0000:05:00.3: new USB bus registered, assigned bus number 4
[    3.393187] xhci_hcd 0000:05:00.3: Host supports USB 3.1 Enhanced SuperSpeed
[    3.393209] usb usb4: Manufacturer: Linux 5.5.2-1-MANJARO xhci-hcd
[    3.393401] xhci_hcd 0000:0c:00.3: xHCI Host Controller
[    3.393403] xhci_hcd 0000:0c:00.3: new USB bus registered, assigned bus number 5
[    3.393507] xhci_hcd 0000:0c:00.3: hcc params 0x0278ffe5 hci version 0x110 quirks 0x0000000000000410
[    3.393666] usb usb5: Manufacturer: Linux 5.5.2-1-MANJARO xhci-hcd
[    3.393829] xhci_hcd 0000:0c:00.3: xHCI Host Controller
[    3.393831] xhci_hcd 0000:0c:00.3: new USB bus registered, assigned bus number 6
[    3.393832] xhci_hcd 0000:0c:00.3: Host supports USB 3.1 Enhanced SuperSpeed
[    3.393854] usb usb6: Manufacturer: Linux 5.5.2-1-MANJARO xhci-hcd
[    3.718798] usb 1-1: new full-speed USB device number 2 using xhci_hcd
[    3.722124] usb 5-2: new high-speed USB device number 2 using xhci_hcd
[    3.862829] usb 6-2: new SuperSpeed Gen 1 USB device number 2 using xhci_hcd
[    4.009214] usb 1-2: new full-speed USB device number 3 using xhci_hcd
[    4.122139] usb 5-2.3: new full-speed USB device number 3 using xhci_hcd
[    4.468793] usb 5-2.4: new full-speed USB device number 4 using xhci_hcd
[   30.972256] usb 6-4: new SuperSpeed Gen 1 USB device number 3 using xhci_hcd
[  109.458885] usb 6-4: reset SuperSpeed Gen 1 USB device number 3 using xhci_hcd

grep -i xhci /boot/config-$(uname -r)
grep: /boot/config-5.5.2-1-MANJARO: No such file or directory

In grub I have

GRUB_CMDLINE_LINUX_DEFAULT="quiet apparmor=1 security=apparmor iommu=soft resume=UUID=babef3c4-12a3-4943-b09e-0efa70e612b6 udev.log_priority=3"

In the BIOS/UEFI I have toggled “Enable IOMMU” between Auto and Enabled.

14

I have tried both Gen 1 and Gen 2.

15

So I have found a solution. I was on the right track with the module blacklisting, but instead of using GRUB to blacklist modules, I should have used modprobe.d/ to blacklist, then regenerate the image. I gave up at blacklisting because I tried to convert instructions from a Debian-based distro to an Arch-based one, and the Arch documentation was out of date.

Symptoms:

  • USB File transfers fail after an unspecified amount of time
  • System may hang / lock up
  • Disconnecting the external drive will resume the system

Determination:

  1. Obtain kernel log from demsg

    sudo dmesg

  2. If you see lines similar to the following, then you have this issue.

    [ 7578.732385] sd 17:0:0:0: [sdd] tag#4 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD OUT 
    [ 7578.732389] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 68 00 00 00 04 00 00 00
    [ 7732.440110] blk_update_request: I/O error, dev sdd, sector 1548838912 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
    [ 7740.848483] INFO: task (ostnamed):9746 blocked for more than 122 seconds.
    [ 7740.848486]       Not tainted 5.5.0-1-MANJARO #1
    [ 7740.848486] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
    [ 7740.848487] (ostnamed)      D    0  9746      1 0x00000084
    [ 7740.848490] Call Trace:
    [ 7740.848499]  ? __schedule+0x2e8/0x7a0
    [ 7740.848502]  schedule+0x46/0xf0
    [ 7740.848505]  rwsem_down_write_slowpath+0x2a2/0x530
    [ 7740.848510]  do_mount+0x3ea/0xa30
    [ 7740.848513]  ? syscall_trace_enter+0x19c/0x2e0
    [ 7740.848515]  __x64_sys_mount+0x8e/0xd0
    [ 7740.848517]  do_syscall_64+0x4e/0x150
    [ 7740.848520]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
    [ 7740.848523] RIP: 0033:0x7f0c5d473e4e
    [ 7740.848527] Code: Bad RIP value.
    [ 7740.848528] RSP: 002b:00007fff60e83378 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
    [ 7740.848530] RAX: ffffffffffffffda RBX: 0000557fdc246630 RCX: 00007f0c5d473e4e
    [ 7740.848530] RDX: 0000000000000000 RSI: 0000557fdc246630 RDI: 0000000000000000
    [ 7740.848531] RBP: 0000557fdc222c78 R08: 0000000000000000 R09: 0000000000000007
    [ 7740.848532] R10: 0000000000001027 R11: 0000000000000206 R12: 0000000000000001
    [ 7740.848533] R13: 00007fff60e833e0 R14: 0000557fdc1b4620 R15: 0000557fdc225288
    [ 7863.725508] INFO: task kworker/u64:6:9002 blocked for more than 122 seconds.
    [ 7863.725510]       Not tainted 5.5.0-1-MANJARO #1
    [ 7863.725511] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
    [ 7863.725512] kworker/u64:6   D    0  9002      2 0x80004080
    [ 7863.725519] Workqueue: writeback wb_workfn (flush-8:48)
    [ 7863.725521] Call Trace:
    [ 7863.725528]  ? __schedule+0x2e8/0x7a0
    [ 7863.725530]  ? __wbt_done+0x30/0x30
    [ 7863.725533]  ? __wbt_done+0x30/0x30
    [ 7863.725534]  schedule+0x46/0xf0
    [ 7863.725536]  io_schedule+0x12/0x40
    [ 7863.725538]  rq_qos_wait+0x106/0x170
    [ 7863.725540]  ? karma_partition+0x240/0x240
    [ 7863.725542]  ? wbt_cleanup_cb+0x20/0x20
    [ 7863.725544]  wbt_wait+0xa1/0xe0
    [ 7863.725547]  __rq_qos_throttle+0x23/0x30
    [ 7863.725549]  blk_mq_make_request+0x14b/0x670
    [ 7863.725553]  generic_make_request+0xf2/0x350
    [ 7863.725555]  submit_bio+0x6e/0x1e0
    [ 7863.725574]  ext4_io_submit+0x49/0x60 [ext4]
    [ 7863.725588]  ext4_writepages+0x7e1/0x1030 [ext4]
    [ 7863.725591]  ? __wb_calc_thresh+0x130/0x130
    [ 7863.725597]  ? do_writepages+0x1c/0x60
    [ 7863.725599]  do_writepages+0x1c/0x60
    [ 7863.725601]  __writeback_single_inode+0x3d/0x3d0
    [ 7863.725603]  ? _raw_spin_lock+0x13/0x30
    [ 7863.725605]  writeback_sb_inodes+0x1f0/0x430
    [ 7863.725609]  __writeback_inodes_wb+0x4c/0xc0
    [ 7863.725611]  wb_writeback+0x2b8/0x360
    [ 7863.725614]  ? get_nr_inodes+0x32/0x50
    [ 7863.725616]  wb_workfn+0x407/0x4e0
    [ 7863.725618]  ? __switch_to_asm+0x40/0x70
    [ 7863.725620]  ? __switch_to_asm+0x34/0x70
    [ 7863.725621]  ? __switch_to_asm+0x40/0x70
    [ 7863.725623]  ? __switch_to_asm+0x34/0x70
    [ 7863.725624]  ? __switch_to_asm+0x40/0x70
    [ 7863.725626]  ? __switch_to_asm+0x34/0x70
    [ 7863.725627]  ? __switch_to_asm+0x40/0x70
    [ 7863.725629]  ? __switch_to_asm+0x34/0x70
    [ 7863.725633]  process_one_work+0x1e2/0x3b0
    [ 7863.725635]  worker_thread+0x4a/0x3d0
    [ 7863.725638]  kthread+0xfb/0x130
    [ 7863.725639]  ? process_one_work+0x3b0/0x3b0
    [ 7863.725640]  ? kthread_park+0x90/0x90
    [ 7863.725642]  ret_from_fork+0x22/0x40
    [ 7863.725646] INFO: task jbd2/sdd1-8:9039 blocked for more than 122 seconds.
    [ 7863.725647]       Not tainted 5.5.0-1-MANJARO #1
    [ 7863.725647] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
    [ 7863.725648] jbd2/sdd1-8     D    0  9039      2 0x80004080
    [ 7863.725650] Call Trace:
    [ 7863.725652]  ? __schedule+0x2e8/0x7a0
    [ 7863.725654]  schedule+0x46/0xf0
    [ 7863.725656]  io_schedule+0x12/0x40
    [ 7863.725658]  wait_on_page_bit+0x139/0x230
    [ 7863.725661]  ? file_fdatawait_range+0x20/0x20
    [ 7863.725663]  __filemap_fdatawait_range+0x8b/0xe0
    [ 7863.725667]  filemap_fdatawait_range_keep_errors+0xe/0x40
    [ 7863.725673]  jbd2_journal_commit_transaction+0xb1d/0x19a0 [jbd2]
    [ 7863.725675]  ? __switch_to_asm+0x40/0x70
    [ 7863.725679]  ? wait_woken+0x70/0x70
    [ 7863.725682]  ? try_to_del_timer_sync+0x57/0x80
    [ 7863.725687]  kjournald2+0xe5/0x2b0 [jbd2]
    [ 7863.725689]  ? wait_woken+0x70/0x70
    [ 7863.725691]  kthread+0xfb/0x130
    [ 7863.725695]  ? commit_timeout+0x10/0x10 [jbd2]
    [ 7863.725696]  ? kthread_park+0x90/0x90
    [ 7863.725698]  ret_from_fork+0x22/0x40
    [ 7863.725705] INFO: task (ostnamed):9746 blocked for more than 245 seconds.
    [ 7863.725706]       Not tainted 5.5.0-1-MANJARO #1
    [ 7863.725706] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
    [ 7863.725707] (ostnamed)      D    0  9746      1 0x00000084
    [ 7863.725708] Call Trace:
    [ 7863.725710]  ? __schedule+0x2e8/0x7a0
    [ 7863.725712]  schedule+0x46/0xf0
    [ 7863.725714]  rwsem_down_write_slowpath+0x2a2/0x530
    [ 7863.725718]  do_mount+0x3ea/0xa30
    [ 7863.725721]  ? syscall_trace_enter+0x19c/0x2e0
    [ 7863.725723]  __x64_sys_mount+0x8e/0xd0
    [ 7863.725726]  do_syscall_64+0x4e/0x150
    [ 7863.725728]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
    [ 7863.725730] RIP: 0033:0x7f0c5d473e4e
    [ 7863.725734] Code: Bad RIP value.
    [ 7863.725734] RSP: 002b:00007fff60e83378 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
    [ 7863.725736] RAX: ffffffffffffffda RBX: 0000557fdc246630 RCX: 00007f0c5d473e4e
    [ 7863.725737] RDX: 0000000000000000 RSI: 0000557fdc246630 RDI: 0000000000000000
    [ 7863.725737] RBP: 0000557fdc222c78 R08: 0000000000000000 R09: 0000000000000007
    [ 7863.725738] R10: 0000000000001027 R11: 0000000000000206 R12: 0000000000000001
    [ 7863.725739] R13: 00007fff60e833e0 R14: 0000557fdc1b4620 R15: 0000557fdc225288
    [ 7918.458925] sd 17:0:0:0: [sdd] tag#0 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
    [ 7918.458927] sd 17:0:0:0: [sdd] tag#0 CDB: Write(16) 8a 00 00 00 00 00 5c 51 70 00 00 00 04 00 00 00
    [ 7918.458930] blk_update_request: I/O error, dev sdd, sector 1548840960 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
    [ 7918.458945] sd 17:0:0:0: [sdd] tag#1 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
    [ 7918.458946] sd 17:0:0:0: [sdd] tag#1 CDB: Write(16) 8a 00 00 00 00 00 ae 84 19 08 00 00 00 38 00 00
    [ 7918.458948] blk_update_request: I/O error, dev sdd, sector 2927892744 op 0x1:(WRITE) flags 0x800 phys_seg 7 prio class 0
    [ 7918.458957] sd 17:0:0:0: [sdd] tag#2 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
    [ 7918.458958] sd 17:0:0:0: [sdd] tag#2 CDB: Write(16) 8a 00 00 00 00 00 5c 51 6c 00 00 00 04 00 00 00
    [ 7918.458959] blk_update_request: I/O error, dev sdd, sector 1548839936 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
    [ 7918.458966] sd 17:0:0:0: [sdd] tag#4 FAILED Result: hostbyte=DID_RESET driverbyte=DRIVER_OK cmd_age=186s
    [ 7918.458968] sd 17:0:0:0: [sdd] tag#4 CDB: Write(16) 8a 00 00 00 00 00 5c 51 74 00 00 00 04 00 00 00
    [ 7918.458969] blk_update_request: I/O error, dev sdd, sector 1548841984 op 0x1:(WRITE) flags 0x4000 phys_seg 128 prio class 0
    [ 7918.460386] audit: type=1130 audit(1580686720.697:135): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'

Cause:

  • Incompatibility between the UAS driver and the USB to SATA bridge in your external enclosure/dock.

Solution:

  • Blacklist the UAS driver/module for your particular enclosure/dock, so it will fallback to a different driver/module.

Resolution for Arch-based Distros:

  1. Connect the drive to your PC via USB

  2. Determine the Vendor ID and Product ID for your enclosure

    lsusb

  3. Locate any lines related to a USB SATA bridge

    Bus 006 Device 003: ID 2109:0711 VIA Labs, Inc. USB3.0 SATA Bridge

  4. This is the VendorID:ProductID

    2109:0711

  5. Create a new file called blacklist_uas.conf in /etc/modprobe.d

    sudo nano /etc/modprobe.d/blacklist_uas.conf

  6. Add the following line, replace VendorID and ProductID using those from your device:

    options usb-storage quirks=VendorID:ProductID:u

  7. Save the file, and close the editor

  8. Determine mkinitcpio preset file

  9. Go to this folder

    cd /etc/mkinitcpio.d

  10. List files

    ls

  11. It should display a .preset file

    linux54.preset.pacsave linux55.preset

  12. Because I am using Linux Kernel 5.5, I will use the linux55 preset

  13. Rebuild the image, be sure to use the correct preset, in my case it is linux55

    sudo mkinitcpio -p linux55

  14. The image should build successfully:

    ==> Building image from preset: /etc/mkinitcpio.d/linux55.preset: 'default'

  -> -k /boot/vmlinuz-5.5-x86_64 -c /etc/mkinitcpio.conf -g /boot/initramfs-5.5-x86_64.img
==> Starting build: 5.5.2-1-MANJARO
  -> Running build hook: [base]
  -> Running build hook: [udev]
  -> Running build hook: [autodetect]
  -> Running build hook: [modconf]
  -> Running build hook: [block]
  -> Running build hook: [keyboard]
  -> Running build hook: [keymap]
  -> Running build hook: [resume]
  -> Running build hook: [filesystems]
==> Generating module dependencies
==> Creating gzip-compressed initcpio image: /boot/initramfs-5.5-x86_64.img
==> Image generation successful
==> Building image from preset: /etc/mkinitcpio.d/linux55.preset: 'fallback'
  -> -k /boot/vmlinuz-5.5-x86_64 -c /etc/mkinitcpio.conf -g /boot/initramfs-5.5-x86_64-fallback.img -S autodetect
==> Starting build: 5.5.2-1-MANJARO
  -> Running build hook: [base]
  -> Running build hook: [udev]
  -> Running build hook: [modconf]
  -> Running build hook: [block]
  -> Running build hook: [keyboard]
  -> Running build hook: [keymap]
  -> Running build hook: [resume]
  -> Running build hook: [filesystems]
==> Generating module dependencies
==> Creating gzip-compressed initcpio image: /boot/initramfs-5.5-x86_64-fallback.img
==> Image generation successful

  15. Restart your machine

  16. Upon restart, test your USB drive by transferring a large amount of files

4 Likes
16

Eureka !

1 Like
17

Interesting, I have been seeing people have UAS issue with the aarh64 5.x kernels but usually it complains about “UAS” in some way. Interesting that yours did not mention UAS.