Fwd: BUG REPORT: USB controller doesn't work after PC sleep

* Fwd: BUG REPORT: USB controller doesn't work after PC sleep
       [not found] <CAFdiRoChCT4+mqPW71oWp1sBLxYKqaOiVHy+jHQ_en7-M_MXTQ@mail.gmail.com>
@ 2020-11-14 15:41 ` Denis Valeev
  0 siblings, 0 replies; only message in thread
From: Denis Valeev @ 2020-11-14 15:41 UTC (permalink / raw)
  To: linux-usb

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

Hello Mathias and Greg.

Sometimes my USB controller doesn't work after PC sleep. After such a
sleep, In journalctl I have these lines:

nov 11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: xHCI host not
responding to stop endpoint command.
nov 11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: USBSTS:
nov 11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: xHCI host controller
not responding, assume dead
nov 11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: HC died; cleaning up

This problem happens not after every sleep, about every third or
fourth. I noticed that the transition to problem sleep takes more time
than to a normal one.

I tried to switch different options related to USB in UEFI without any result.

My system:
Asus TUF Gaming X570-Plus (Wi-Fi), UEFI version is 2802 from 2020/10/23
Ryzen 3950X
ArchLinux with 5.9.8 kernel
External USB connected devices: mouse and keyboard only

Let me know if you need more information. If necessary, I can build a
debug version of the kernel.

BR,
Den

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

09 17:51:17 q kernel: PM: suspend entry (deep)
09 17:51:17 q kernel: Filesystems sync: 0.044 seconds
11 21:02:40 q kernel: Freezing user space processes ... (elapsed 0.001 seconds) done.
11 21:02:40 q kernel: OOM killer disabled.
11 21:02:40 q kernel: Freezing remaining freezable tasks ... (elapsed 0.000 seconds) done.
11 21:02:40 q kernel: printk: Suspending console(s) (use no_console_suspend to debug)
11 21:02:40 q kernel: serial 00:04: disabled
11 21:02:40 q kernel: sd 5:0:0:0: [sda] Synchronizing SCSI cache
11 21:02:40 q kernel: sd 5:0:0:0: [sda] Stopping disk
11 21:02:40 q kernel: sd 6:0:0:0: [sdb] Synchronizing SCSI cache
11 21:02:40 q kernel: sd 6:0:0:0: [sdb] Stopping disk
11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: xHCI host not responding to stop endpoint command.
11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: USBSTS:
11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: xHCI host controller not responding, assume dead
11 21:02:40 q kernel: xhci_hcd 0000:06:00.1: HC died; cleaning up
11 21:02:40 q kernel: ACPI: Preparing to enter system sleep state S3
11 21:02:40 q kernel: PM: Saving platform NVS memory
11 21:02:40 q kernel: Disabling non-boot CPUs ...
11 21:02:40 q kernel: IRQ 114: no longer affine to CPU1
11 21:02:40 q kernel: smpboot: CPU 1 is now offline
11 21:02:40 q kernel: IRQ 115: no longer affine to CPU2
11 21:02:40 q kernel: smpboot: CPU 2 is now offline
11 21:02:40 q kernel: IRQ 116: no longer affine to CPU3
11 21:02:40 q kernel: smpboot: CPU 3 is now offline
11 21:02:40 q kernel: IRQ 117: no longer affine to CPU4
11 21:02:40 q kernel: smpboot: CPU 4 is now offline
11 21:02:40 q kernel: IRQ 118: no longer affine to CPU5
11 21:02:40 q kernel: smpboot: CPU 5 is now offline
11 21:02:40 q kernel: IRQ 119: no longer affine to CPU6
11 21:02:40 q kernel: smpboot: CPU 6 is now offline
11 21:02:40 q kernel: IRQ 120: no longer affine to CPU7
11 21:02:40 q kernel: smpboot: CPU 7 is now offline
11 21:02:40 q kernel: IRQ 121: no longer affine to CPU8
11 21:02:40 q kernel: smpboot: CPU 8 is now offline
11 21:02:40 q kernel: IRQ 122: no longer affine to CPU9
11 21:02:40 q kernel: smpboot: CPU 9 is now offline
11 21:02:40 q kernel: IRQ 123: no longer affine to CPU10
11 21:02:40 q kernel: smpboot: CPU 10 is now offline
11 21:02:40 q kernel: smpboot: CPU 11 is now offline
11 21:02:40 q kernel: smpboot: CPU 12 is now offline
11 21:02:40 q kernel: smpboot: CPU 13 is now offline
11 21:02:40 q kernel: smpboot: CPU 14 is now offline
11 21:02:40 q kernel: smpboot: CPU 15 is now offline
11 21:02:40 q kernel: smpboot: CPU 16 is now offline
11 21:02:40 q kernel: smpboot: CPU 17 is now offline
11 21:02:40 q kernel: smpboot: CPU 18 is now offline
11 21:02:40 q kernel: smpboot: CPU 19 is now offline
11 21:02:40 q kernel: smpboot: CPU 20 is now offline
11 21:02:40 q kernel: smpboot: CPU 21 is now offline
11 21:02:40 q kernel: smpboot: CPU 22 is now offline
11 21:02:40 q kernel: smpboot: CPU 23 is now offline
11 21:02:40 q kernel: smpboot: CPU 24 is now offline
11 21:02:40 q kernel: smpboot: CPU 25 is now offline
11 21:02:40 q kernel: smpboot: CPU 26 is now offline
11 21:02:40 q kernel: smpboot: CPU 27 is now offline
11 21:02:40 q kernel: smpboot: CPU 28 is now offline
11 21:02:40 q kernel: smpboot: CPU 29 is now offline
11 21:02:40 q kernel: smpboot: CPU 30 is now offline
11 21:02:40 q kernel: smpboot: CPU 31 is now offline
11 21:02:40 q kernel: ACPI: Low-level resume complete
11 21:02:40 q kernel: PM: Restoring platform NVS memory
11 21:02:40 q kernel: LVT offset 0 assigned for vector 0x400
11 21:02:40 q kernel: Enabling non-boot CPUs ...
11 21:02:40 q kernel: x86: Booting SMP configuration:
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 1 APIC 0x2
11 21:02:40 q kernel: microcode: CPU1: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C002: Found 2 idle states
11 21:02:40 q kernel: CPU1 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 2 APIC 0x4
11 21:02:40 q kernel: microcode: CPU2: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C004: Found 2 idle states
11 21:02:40 q kernel: CPU2 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 3 APIC 0x6
11 21:02:40 q kernel: microcode: CPU3: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C006: Found 2 idle states
11 21:02:40 q kernel: CPU3 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 4 APIC 0x8
11 21:02:40 q kernel: microcode: CPU4: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C008: Found 2 idle states
11 21:02:40 q kernel: CPU4 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 5 APIC 0xa
11 21:02:40 q kernel: microcode: CPU5: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C00A: Found 2 idle states
11 21:02:40 q kernel: CPU5 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 6 APIC 0xc
11 21:02:40 q kernel: microcode: CPU6: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C00C: Found 2 idle states
11 21:02:40 q kernel: CPU6 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 7 APIC 0xe
11 21:02:40 q kernel: microcode: CPU7: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C00E: Found 2 idle states
11 21:02:40 q kernel: CPU7 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 8 APIC 0x10
11 21:02:40 q kernel: microcode: CPU8: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C010: Found 2 idle states
11 21:02:40 q kernel: CPU8 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 9 APIC 0x12
11 21:02:40 q kernel: microcode: CPU9: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C012: Found 2 idle states
11 21:02:40 q kernel: CPU9 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 10 APIC 0x14
11 21:02:40 q kernel: microcode: CPU10: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C014: Found 2 idle states
11 21:02:40 q kernel: CPU10 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 11 APIC 0x16
11 21:02:40 q kernel: microcode: CPU11: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C016: Found 2 idle states
11 21:02:40 q kernel: CPU11 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 12 APIC 0x18
11 21:02:40 q kernel: microcode: CPU12: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C018: Found 2 idle states
11 21:02:40 q kernel: CPU12 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 13 APIC 0x1a
11 21:02:40 q kernel: microcode: CPU13: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C01A: Found 2 idle states
11 21:02:40 q kernel: CPU13 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 14 APIC 0x1c
11 21:02:40 q kernel: microcode: CPU14: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C01C: Found 2 idle states
11 21:02:40 q kernel: CPU14 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 15 APIC 0x1e
11 21:02:40 q kernel: microcode: CPU15: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C01E: Found 2 idle states
11 21:02:40 q kernel: CPU15 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 16 APIC 0x1
11 21:02:40 q kernel: microcode: CPU16: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C001: Found 2 idle states
11 21:02:40 q kernel: CPU16 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 17 APIC 0x3
11 21:02:40 q kernel: microcode: CPU17: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C003: Found 2 idle states
11 21:02:40 q kernel: CPU17 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 18 APIC 0x5
11 21:02:40 q kernel: microcode: CPU18: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C005: Found 2 idle states
11 21:02:40 q kernel: CPU18 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 19 APIC 0x7
11 21:02:40 q kernel: microcode: CPU19: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C007: Found 2 idle states
11 21:02:40 q kernel: CPU19 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 20 APIC 0x9
11 21:02:40 q kernel: microcode: CPU20: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C009: Found 2 idle states
11 21:02:40 q kernel: CPU20 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 21 APIC 0xb
11 21:02:40 q kernel: microcode: CPU21: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C00B: Found 2 idle states
11 21:02:40 q kernel: CPU21 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 22 APIC 0xd
11 21:02:40 q kernel: microcode: CPU22: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C00D: Found 2 idle states
11 21:02:40 q kernel: CPU22 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 23 APIC 0xf
11 21:02:40 q kernel: microcode: CPU23: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C00F: Found 2 idle states
11 21:02:40 q kernel: CPU23 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 24 APIC 0x11
11 21:02:40 q kernel: microcode: CPU24: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C011: Found 2 idle states
11 21:02:40 q kernel: CPU24 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 25 APIC 0x13
11 21:02:40 q kernel: microcode: CPU25: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C013: Found 2 idle states
11 21:02:40 q kernel: CPU25 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 26 APIC 0x15
11 21:02:40 q kernel: microcode: CPU26: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C015: Found 2 idle states
11 21:02:40 q kernel: CPU26 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 27 APIC 0x17
11 21:02:40 q kernel: microcode: CPU27: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C017: Found 2 idle states
11 21:02:40 q kernel: CPU27 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 28 APIC 0x19
11 21:02:40 q kernel: microcode: CPU28: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C019: Found 2 idle states
11 21:02:40 q kernel: CPU28 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 29 APIC 0x1b
11 21:02:40 q kernel: microcode: CPU29: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C01B: Found 2 idle states
11 21:02:40 q kernel: CPU29 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 30 APIC 0x1d
11 21:02:40 q kernel: microcode: CPU30: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C01D: Found 2 idle states
11 21:02:40 q kernel: CPU30 is up
11 21:02:40 q kernel: smpboot: Booting Node 0 Processor 31 APIC 0x1f
11 21:02:40 q kernel: microcode: CPU31: patch_level=0x08701021
11 21:02:40 q kernel: ACPI: \_PR_.C01F: Found 2 idle states
11 21:02:40 q kernel: CPU31 is up
11 21:02:40 q kernel: ACPI: Waking up from system sleep state S3
11 21:02:40 q kernel: sd 6:0:0:0: [sdb] Starting disk
11 21:02:40 q kernel: sd 5:0:0:0: [sda] Starting disk
11 21:02:40 q kernel: serial 00:04: activated
11 21:02:40 q kernel: nvme nvme0: Shutdown timeout set to 8 seconds
11 21:02:40 q kernel: nvme nvme0: 32/0/0 default/read/poll queues
11 21:02:40 q kernel: ata1: SATA link down (SStatus 0 SControl 300)
11 21:02:40 q kernel: ata6: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
11 21:02:40 q kernel: ata6.00: supports DRM functions and may not be fully accessible
11 21:02:40 q kernel: ata6.00: disabling queued TRIM support
11 21:02:40 q kernel: ata6.00: supports DRM functions and may not be fully accessible
11 21:02:40 q kernel: ata6.00: disabling queued TRIM support
11 21:02:40 q kernel: ata6.00: configured for UDMA/133
11 21:02:40 q kernel: OOM killer enabled.
11 21:02:40 q kernel: Restarting tasks ... 
11 21:02:40 q kernel: usb 1-5: USB disconnect, device number 2
11 21:02:40 q kernel: done.

^ permalink raw reply	[flat|nested] only message in thread