Re: Strange issues with UAS URB cancellation

[Marc SCHAEFER <schaefer@alphanet.ch>]

Hello,


On Tue, Sep 03, 2024 at 09:48:22AM +0200, Micha?? Pecio wrote:
> [ I changed the title a little. And please use "reply to all" when

I hope it now works like you want it.

> I can offer this patch for testing (on 6.11-rc5), which tries to:

Thank you, I applied + recompiled.  After a while (~1 hour), I got a lot of
messages in dmesg, slowing down the md raidcheck to a crawl.

So, after about two hours of md raidcheck of the array at ~330 MByte/s:

Sep  3 13:53:43 video kernel: [ 7193.705199] xhci_hcd 0000:01:00.0: Stop Endpoint Context Error & Stopped on slot 12 ep 10
Sep  3 13:53:43 video kernel: [ 7193.705209] xhci_hcd 0000:01:00.0: Stop ep completion ctx error, ep is running
Sep  3 13:53:43 video kernel: [ 7193.705461] xhci_hcd 0000:01:00.0: Stop Endpoint Context Error & Stopped on slot 12 ep 10
Sep  3 13:53:43 video kernel: [ 7193.705469] xhci_hcd 0000:01:00.0: Stop ep completion ctx error, ep is running
Sep  3 13:53:43 video kernel: [ 7193.705754] xhci_hcd 0000:01:00.0: Stop Endpoint Context Error & Stopped on slot 12 ep 10
Sep  3 13:53:43 video kernel: [ 7193.705759] xhci_hcd 0000:01:00.0: Stop ep completion ctx error, ep is running

[ ... and many like this ... ]

then it gets more interesting:

Sep  3 13:53:55 video kernel: [ 7205.983631] sd 18:0:0:0: [sde] tag#5 uas_eh_abort_handler 0 uas-tag 6 inflight: CMD IN 
Sep  3 13:53:55 video kernel: [ 7205.983635] sd 18:0:0:0: [sde] tag#5 CDB: Read(16) 88 00 00 00 00 00 8c cf e4 00 00 00 04 00 00 00
Sep  3 13:54:21 video kernel: [ 7232.213557] usb 3-1.1.4: stat urb: no pending cmd for uas-tag 6

then the kernel complains about:

Sep  3 13:56:41 video kernel: [ 7371.838240] INFO: task smartd:906 blocked for more than 120 seconds.
Sep  3 13:56:41 video kernel: [ 7371.838246]       Tainted: G            E      6.11.0-rc5 #2
Sep  3 13:56:41 video kernel: [ 7371.838248] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Sep  3 13:56:41 video kernel: [ 7371.838249] task:smartd          state:D stack:0     pid:906   tgid:906   ppid:1      flags:0x00000000

(and a few other utility programs, including the md0_resync kernel task)

then:

Sep  3 14:00:42 video kernel: [ 7613.502312] Future hung task reports are suppressed, see sysctl kernel.hung_task_warnings

Thank you :)