2021-02-25 00:56:25

by Sedat Dilek

[permalink] [raw]
Subject: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

Hi Mathias,

I am here on Linux-v5.11-10201-gc03c21ba6f4e.

I see a lot xhci-resets in my dmesg-log:

root# LC_ALL=C dmesg -T | grep 'usb 4-1: reset SuperSpeed Gen 1 USB
device number 2 using xhci_hcd' | wc -l
75

This is what I have:

root# lsusb -s 004:001
Bus 004 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub

root# lsusb -s 004:002
Bus 004 Device 002: ID 174c:55aa ASMedia Technology Inc. ASM1051E SATA
6Gb/s bridge, ASM1053E SATA 6Gb/s bridge, ASM1153 SATA 3Gb/s bridge,
ASM1153E SATA 6Gb/s bridge

My external USB 3.0 HDD contains the partition with my Debian-system
and is attached to the above xhci bus/device.

Can you enlighten what this means?
Is this a known issue?
Is there a fix around?

BTW, in which Git tree is the xhci development happening?
Can you point me to it?

I am attaching my linux-config and full dmesg-log.

Also I have attached outputs of:

$ sudo lsusb -vvv -d 1d6b:0003
$ sudo lsusb -vvv -d 174c:55aa

If you need further information, please let me know.

Thanks.

Regards,
- Sedat -


Attachments:
dmesg-T_5.11.0-10201.1-amd64-clang13-lto.txt (82.76 kB)
config-5.11.0-10201.1-amd64-clang13-lto (233.74 kB)
lsusb-vvv-d-1d6b-0003.txt (2.69 kB)
lsusb-vvv-d-174c-55aa.txt (3.05 kB)
Download all attachments

2021-03-08 03:01:49

by Alan Stern

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

On Sun, Mar 07, 2021 at 05:57:39PM +0100, Sedat Dilek wrote:
> On Sun, Mar 7, 2021 at 4:46 PM Alan Stern <[email protected]> wrote:
> >
> > On Sat, Mar 06, 2021 at 09:49:00PM +0100, Sedat Dilek wrote:
> >
> > > For testing purposes, I stopped these systemd services:
> > >
> > > 1. systemctl stop smartmontools.service
> > >
> > > 2. systemctl stop udisks2.service
> > >
> > > Last seen xhci-reset:
> > >
> > > [Sat Mar 6 21:37:40 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > >
> > > So, that every 10min xhci-reset was caused by pool-udisksd from udisks2.service.
> >
> > You have found the cause of your problem! Great!
> >
> > And now, obviously order to fix the problem, you'll have to look into
> > the udisks2 service. Maybe you can configure it so that it won't send
> > the problem-causing commands.
> >
>
> I tried yesterday to add --debug option to the ExexStart line of
> udisks2.service, but did not see anything helpful.
>
> There exist more user-space than udisks2 causing these xhci-resets.
> The cmd#s are also clear: A1 and 85 - whatever they mean.

Those are the two prefixes which indicate an ATA command is present.
You can find them listed as ATA_12 and ATA_16 in
include/scsi/scsi_proto.h.

> As said with Linux v5.10.y and Linux v5.11 I have not seen this.

Have you tried setting the quirk flag we discussed earlier _and_ turning
off udisks2? Maybe also turning off the other services which generate
these commands? Perhaps you'll find that when the quirk flag is
present, some of those programs _don't_ generate any ATA commands.

> What about CCing linux-block and linux-scsi people?

Sure, go ahead if you want to.

Alan Stern

2021-03-12 17:02:42

by Sedat Dilek

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

On Sun, Mar 7, 2021 at 6:07 PM Alan Stern <[email protected]> wrote:
>
> On Sun, Mar 07, 2021 at 05:57:39PM +0100, Sedat Dilek wrote:
> > On Sun, Mar 7, 2021 at 4:46 PM Alan Stern <[email protected]> wrote:
> > >
> > > On Sat, Mar 06, 2021 at 09:49:00PM +0100, Sedat Dilek wrote:
> > >
> > > > For testing purposes, I stopped these systemd services:
> > > >
> > > > 1. systemctl stop smartmontools.service
> > > >
> > > > 2. systemctl stop udisks2.service
> > > >
> > > > Last seen xhci-reset:
> > > >
> > > > [Sat Mar 6 21:37:40 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > > >
> > > > So, that every 10min xhci-reset was caused by pool-udisksd from udisks2.service.
> > >
> > > You have found the cause of your problem! Great!
> > >
> > > And now, obviously order to fix the problem, you'll have to look into
> > > the udisks2 service. Maybe you can configure it so that it won't send
> > > the problem-causing commands.
> > >
> >
> > I tried yesterday to add --debug option to the ExexStart line of
> > udisks2.service, but did not see anything helpful.
> >
> > There exist more user-space than udisks2 causing these xhci-resets.
> > The cmd#s are also clear: A1 and 85 - whatever they mean.
>
> Those are the two prefixes which indicate an ATA command is present.
> You can find them listed as ATA_12 and ATA_16 in
> include/scsi/scsi_proto.h.
>
> > As said with Linux v5.10.y and Linux v5.11 I have not seen this.
>
> Have you tried setting the quirk flag we discussed earlier _and_ turning
> off udisks2? Maybe also turning off the other services which generate
> these commands? Perhaps you'll find that when the quirk flag is
> present, some of those programs _don't_ generate any ATA commands.
>

I passed as a kernel-command-line parameter: usb-storage.quirks=174c:55aa:t

dmesg says:

[Fri Mar 12 17:25:33 2021] usb-storage 4-1:1.0: Quirks match for vid
174c pid 55aa: 2400000

Without that parameter (there is an existing Quirks for my ASMedia USB
3.0 controller in the kernel-sources):

[Fri Mar 12 11:49:03 2021] usb-storage 4-1:1.0: Quirks match for vid
174c pid 55aa: 400000

NOTE: 2400000 (new) VS. 400000 (old)

The parameter is really active:

root# cat /sys/module/usb_storage/parameters/quirks
174c:55aa:t

The total number of xhci-resets is reduced:

root# LC_ALL=C dmesg -T | egrep 'usb 4-1: reset SuperSpeed Gen 1 USB
device number 2 using xhci_hcd' | wc -l
24

Together with your diff, I see in dmesg now:

# LC_ALL=C dmesg -T | egrep 'reset|SCSI ioctl error'
[Fri Mar 12 17:25:32 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:25:32 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:25:33 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:33 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:33 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:36 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:38 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:38 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:38 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 17:25:58 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:25:58 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:26:05 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:07 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:07 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:14 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:14 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:27:37 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 17:27:37 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 17:27:39 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 17:27:40 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 17:36:23 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:23 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd

So, the quirk you recommended seems to silence the xhci-resets -
passed as a kernel-command-line parameter.

Furthermore, I tried via:

#1: /etc/modules-load.d/usb-storage.conf
options usb-storage quirks=174c:55aa:t

Should this be with a dot than a space?
options usb-storage.quirks=174c:55aa:t

#2: echo '174c:55aa:t' > /sys/module/usb_storage/parameters/quirks
...after system was booted into

Both had no effect.

After 31mins of uptime I still see above 24 xhci-resets.

I have attached my linux-config and full dmesg-log.

- Sedat -


Attachments:
dmesg-T_5.12.0-rc2-6-amd64-clang12-cfi.txt (81.16 kB)
config-5.12.0-rc2-6-amd64-clang12-cfi (233.78 kB)
Download all attachments

2021-03-12 17:04:38

by Sedat Dilek

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

On Fri, Mar 12, 2021 at 5:57 PM Sedat Dilek <[email protected]> wrote:
>
> On Sun, Mar 7, 2021 at 6:07 PM Alan Stern <[email protected]> wrote:
> >
> > On Sun, Mar 07, 2021 at 05:57:39PM +0100, Sedat Dilek wrote:
> > > On Sun, Mar 7, 2021 at 4:46 PM Alan Stern <[email protected]> wrote:
> > > >
> > > > On Sat, Mar 06, 2021 at 09:49:00PM +0100, Sedat Dilek wrote:
> > > >
> > > > > For testing purposes, I stopped these systemd services:
> > > > >
> > > > > 1. systemctl stop smartmontools.service
> > > > >
> > > > > 2. systemctl stop udisks2.service
> > > > >
> > > > > Last seen xhci-reset:
> > > > >
> > > > > [Sat Mar 6 21:37:40 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > > > >
> > > > > So, that every 10min xhci-reset was caused by pool-udisksd from udisks2.service.
> > > >
> > > > You have found the cause of your problem! Great!
> > > >
> > > > And now, obviously order to fix the problem, you'll have to look into
> > > > the udisks2 service. Maybe you can configure it so that it won't send
> > > > the problem-causing commands.
> > > >
> > >
> > > I tried yesterday to add --debug option to the ExexStart line of
> > > udisks2.service, but did not see anything helpful.
> > >
> > > There exist more user-space than udisks2 causing these xhci-resets.
> > > The cmd#s are also clear: A1 and 85 - whatever they mean.
> >
> > Those are the two prefixes which indicate an ATA command is present.
> > You can find them listed as ATA_12 and ATA_16 in
> > include/scsi/scsi_proto.h.
> >
> > > As said with Linux v5.10.y and Linux v5.11 I have not seen this.
> >
> > Have you tried setting the quirk flag we discussed earlier _and_ turning
> > off udisks2? Maybe also turning off the other services which generate
> > these commands? Perhaps you'll find that when the quirk flag is
> > present, some of those programs _don't_ generate any ATA commands.
> >
>
> I passed as a kernel-command-line parameter: usb-storage.quirks=174c:55aa:t
>
> dmesg says:
>
> [Fri Mar 12 17:25:33 2021] usb-storage 4-1:1.0: Quirks match for vid
> 174c pid 55aa: 2400000
>
> Without that parameter (there is an existing Quirks for my ASMedia USB
> 3.0 controller in the kernel-sources):
>
> [Fri Mar 12 11:49:03 2021] usb-storage 4-1:1.0: Quirks match for vid
> 174c pid 55aa: 400000
>
> NOTE: 2400000 (new) VS. 400000 (old)
>
> The parameter is really active:
>
> root# cat /sys/module/usb_storage/parameters/quirks
> 174c:55aa:t
>
> The total number of xhci-resets is reduced:
>
> root# LC_ALL=C dmesg -T | egrep 'usb 4-1: reset SuperSpeed Gen 1 USB
> device number 2 using xhci_hcd' | wc -l
> 24
>
> Together with your diff, I see in dmesg now:
>
> # LC_ALL=C dmesg -T | egrep 'reset|SCSI ioctl error'
> [Fri Mar 12 17:25:32 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:25:32 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:25:33 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:33 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:33 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:34 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:35 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:36 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:36 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:37 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:38 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:38 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:38 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 17:25:58 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:25:58 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:03 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:26:05 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:06 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:07 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:07 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 17:26:13 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:14 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:14 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:18 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:23 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:26:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:27:37 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 17:27:37 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 17:27:39 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 17:27:40 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 17:36:23 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:23 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:36:24 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:33 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:38:34 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:57 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 17:40:58 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
>
> So, the quirk you recommended seems to silence the xhci-resets -
> passed as a kernel-command-line parameter.
>
> Furthermore, I tried via:
>
> #1: /etc/modules-load.d/usb-storage.conf
> options usb-storage quirks=174c:55aa:t
>
> Should this be with a dot than a space?
> options usb-storage.quirks=174c:55aa:t
>

Grrr, space is right - I need to do an update-initramfs.

- Sedat -

> #2: echo '174c:55aa:t' > /sys/module/usb_storage/parameters/quirks
> ...after system was booted into
>
> Both had no effect.
>
> After 31mins of uptime I still see above 24 xhci-resets.
>
> I have attached my linux-config and full dmesg-log.
>
> - Sedat -

2021-03-12 17:44:34

by Sedat Dilek

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

OK, now for the records:

[ /etc/modprobe.d/usb-storage.conf ]

# Add quirks for USB Mass Storage devices
#
# Link: https://www.kernel.org/doc/html/latest/admin-guide/kernel-parameters.html
#
# Option #1: Use Kernel command line parameter
# [1] Usage: usb-storage.quirks=<VID:PID:Flags>
# [2] VendorID (VID) and ProductID (PID):
# ASMedia M1042 USB-3.0 controller: VID: 174c PID: 55aa
# [3] Flags:
# t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);
# u = IGNORE_UAS (don't bind to the uas driver);
# [4] Example: usb-storage.quirks=174c:55aa:t
#
# Option #2: Set quirk via sysfs
# DEBUG: echo '174c:55aa:t' > /sys/module/usb_storage/parameters/quirks
#
# Option #3: Pass options via /etc/modprobe.d/usb-storage.conf (this file here)
# XXX: Do NOT forget to run `update-initramfs` command!
options usb-storage quirks=174c:55aa:t
- EOF -

With generating a new /boot/initrd.img via `update-initramfs` this
looks good to me:

root# LC_ALL=C dmesg -T | egrep -i 'quirks|reset|SCSI ioctl error'
[Fri Mar 12 18:25:56 2021] xhci_hcd 0000:03:00.0: hcc params
0x0200f180 hci version 0x96 quirks 0x0000000000080000
[Fri Mar 12 18:25:57 2021] usb-storage 4-1:1.0: Quirks match for vid
174c pid 55aa: 2400000
[Fri Mar 12 18:25:57 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:25:57 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:01 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
number 2 using xhci_hcd
[Fri Mar 12 18:26:24 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:24 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:29 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
[Fri Mar 12 18:26:39 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:39 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd A1, prog ata_id
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
[Fri Mar 12 18:26:43 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:43 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:28:09 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 18:28:09 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 18:28:10 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 18:28:11 2021] SCSI ioctl error, cmd 85, prog smartctl
[Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
[Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd

Your diff now should say; s/SCSI ioctl error/SCSI ioctl info'.

Alan, so "t" flags should be added as a quirks to linux-kernel sources...

t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);

...for my ASMedia USB-3.0 controller?

- Sedat -

2021-03-12 18:07:15

by Alan Stern

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

On Fri, Mar 12, 2021 at 06:41:58PM +0100, Sedat Dilek wrote:
> OK, now for the records:
>
> [ /etc/modprobe.d/usb-storage.conf ]
>
> # Add quirks for USB Mass Storage devices
> #
> # Link: https://www.kernel.org/doc/html/latest/admin-guide/kernel-parameters.html
> #
> # Option #1: Use Kernel command line parameter
> # [1] Usage: usb-storage.quirks=<VID:PID:Flags>
> # [2] VendorID (VID) and ProductID (PID):
> # ASMedia M1042 USB-3.0 controller: VID: 174c PID: 55aa
> # [3] Flags:
> # t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);
> # u = IGNORE_UAS (don't bind to the uas driver);
> # [4] Example: usb-storage.quirks=174c:55aa:t
> #
> # Option #2: Set quirk via sysfs
> # DEBUG: echo '174c:55aa:t' > /sys/module/usb_storage/parameters/quirks
> #
> # Option #3: Pass options via /etc/modprobe.d/usb-storage.conf (this file here)
> # XXX: Do NOT forget to run `update-initramfs` command!
> options usb-storage quirks=174c:55aa:t
> - EOF -
>
> With generating a new /boot/initrd.img via `update-initramfs` this
> looks good to me:
>
> root# LC_ALL=C dmesg -T | egrep -i 'quirks|reset|SCSI ioctl error'
> [Fri Mar 12 18:25:56 2021] xhci_hcd 0000:03:00.0: hcc params
> 0x0200f180 hci version 0x96 quirks 0x0000000000080000
> [Fri Mar 12 18:25:57 2021] usb-storage 4-1:1.0: Quirks match for vid
> 174c pid 55aa: 2400000
> [Fri Mar 12 18:25:57 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:25:57 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:01 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> number 2 using xhci_hcd
> [Fri Mar 12 18:26:24 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:24 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:29 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> [Fri Mar 12 18:26:39 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:39 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd A1, prog ata_id
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> [Fri Mar 12 18:26:43 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:43 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:28:09 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 18:28:09 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 18:28:10 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 18:28:11 2021] SCSI ioctl error, cmd 85, prog smartctl
> [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd

Although it's not conclusive, this log seems to indicate that ata_id
is the only program causing resets. Have you tried preventing the
ata_id program from running (for example, by renaming it)?

> Your diff now should say; s/SCSI ioctl error/SCSI ioctl info'.

No, it shouldn't. The log message itself is an info, but the event it
reports is an error.

> Alan, so "t" flags should be added as a quirks to linux-kernel sources...
>
> t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);
>
> ...for my ASMedia USB-3.0 controller?

That's not at all clear. This is a very common and popular device,
and nobody else has reported these problems. It could be that
something is odd about your particular drive or computer, not these
drives in general.

Alan Stern

2021-03-12 18:28:52

by Sedat Dilek

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

On Fri, Mar 12, 2021 at 7:05 PM Alan Stern <[email protected]> wrote:
>
> On Fri, Mar 12, 2021 at 06:41:58PM +0100, Sedat Dilek wrote:
> > OK, now for the records:
> >
> > [ /etc/modprobe.d/usb-storage.conf ]
> >
> > # Add quirks for USB Mass Storage devices
> > #
> > # Link: https://www.kernel.org/doc/html/latest/admin-guide/kernel-parameters.html
> > #
> > # Option #1: Use Kernel command line parameter
> > # [1] Usage: usb-storage.quirks=<VID:PID:Flags>
> > # [2] VendorID (VID) and ProductID (PID):
> > # ASMedia M1042 USB-3.0 controller: VID: 174c PID: 55aa
> > # [3] Flags:
> > # t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);
> > # u = IGNORE_UAS (don't bind to the uas driver);
> > # [4] Example: usb-storage.quirks=174c:55aa:t
> > #
> > # Option #2: Set quirk via sysfs
> > # DEBUG: echo '174c:55aa:t' > /sys/module/usb_storage/parameters/quirks
> > #
> > # Option #3: Pass options via /etc/modprobe.d/usb-storage.conf (this file here)
> > # XXX: Do NOT forget to run `update-initramfs` command!
> > options usb-storage quirks=174c:55aa:t
> > - EOF -
> >
> > With generating a new /boot/initrd.img via `update-initramfs` this
> > looks good to me:
> >
> > root# LC_ALL=C dmesg -T | egrep -i 'quirks|reset|SCSI ioctl error'
> > [Fri Mar 12 18:25:56 2021] xhci_hcd 0000:03:00.0: hcc params
> > 0x0200f180 hci version 0x96 quirks 0x0000000000080000
> > [Fri Mar 12 18:25:57 2021] usb-storage 4-1:1.0: Quirks match for vid
> > 174c pid 55aa: 2400000
> > [Fri Mar 12 18:25:57 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:25:57 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:25:58 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:25:59 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:00 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:01 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:01 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:02 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:03 2021] usb 4-1: reset SuperSpeed Gen 1 USB device
> > number 2 using xhci_hcd
> > [Fri Mar 12 18:26:24 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:24 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:29 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:30 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:31 2021] SCSI ioctl error, cmd 85, prog smartd
> > [Fri Mar 12 18:26:39 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:39 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd A1, prog ata_id
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:40 2021] SCSI ioctl error, cmd 85, prog hdparm
> > [Fri Mar 12 18:26:43 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:43 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:44 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:49 2021] SCSI ioctl error, cmd 85, prog udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:26:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:28:09 2021] SCSI ioctl error, cmd 85, prog smartctl
> > [Fri Mar 12 18:28:09 2021] SCSI ioctl error, cmd 85, prog smartctl
> > [Fri Mar 12 18:28:10 2021] SCSI ioctl error, cmd 85, prog smartctl
> > [Fri Mar 12 18:28:11 2021] SCSI ioctl error, cmd 85, prog smartctl
> > [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:49 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
> > [Fri Mar 12 18:36:50 2021] SCSI ioctl error, cmd 85, prog pool-udisksd
>
> Although it's not conclusive, this log seems to indicate that ata_id
> is the only program causing resets. Have you tried preventing the
> ata_id program from running (for example, by renaming it)?
>

This is /lib/udev/ata_id from Debian's udev package.

> > Your diff now should say; s/SCSI ioctl error/SCSI ioctl info'.
>
> No, it shouldn't. The log message itself is an info, but the event it
> reports is an error.
>

OK.
Some of these SCSI ioctl errors are not causing a xhci-reset.

> > Alan, so "t" flags should be added as a quirks to linux-kernel sources...
> >
> > t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);
> >
> > ...for my ASMedia USB-3.0 controller?
>
> That's not at all clear. This is a very common and popular device,
> and nobody else has reported these problems. It could be that
> something is odd about your particular drive or computer, not these
> drives in general.
>

So, the external USB-3.0 HDD is now in "UAS only" mode/status.

Cannot judge if things got better or not.

- Sedat -

2021-03-12 21:58:28

by Alan Stern

[permalink] [raw]
Subject: Re: [xhci] usb 4-1: reset SuperSpeed Gen 1 USB device number 2 using xhci_hcd

On Fri, Mar 12, 2021 at 07:26:31PM +0100, Sedat Dilek wrote:
> On Fri, Mar 12, 2021 at 7:05 PM Alan Stern <[email protected]> wrote:

> > Although it's not conclusive, this log seems to indicate that ata_id
> > is the only program causing resets. Have you tried preventing the
> > ata_id program from running (for example, by renaming it)?
> >
>
> This is /lib/udev/ata_id from Debian's udev package.

That does not answer my question.

> > > Your diff now should say; s/SCSI ioctl error/SCSI ioctl info'.
> >
> > No, it shouldn't. The log message itself is an info, but the event it
> > reports is an error.
> >
>
> OK.
> Some of these SCSI ioctl errors are not causing a xhci-reset.

Yes, I noticed that. In fact, the commands that cause a reset are all
A1 (and not all of them), never 85.

> > > Alan, so "t" flags should be added as a quirks to linux-kernel sources...
> > >
> > > t = NO_ATA_1X (don't allow ATA(12) and ATA(16) commands, uas only);
> > >
> > > ...for my ASMedia USB-3.0 controller?
> >
> > That's not at all clear. This is a very common and popular device,
> > and nobody else has reported these problems. It could be that
> > something is odd about your particular drive or computer, not these
> > drives in general.
> >
>
> So, the external USB-3.0 HDD is now in "UAS only" mode/status.

Why? Did you change something?

Alan Stern

> Cannot judge if things got better or not.
>
> - Sedat -