Arch Linux

siggiae

Member

Registered: 2009-02-24

Posts: 8

Suspends fails the first time, but succeeds the second time

Hi all,

I am running Arch Linux on my Dell XPS 15 9530 laptop, and overall I am very happy with the combination. I have however had some issues with suspending.

The problem is that the first time I try to suspend the machine it seems to go to sleep, but then two seconds later it automatically wakes up again. If I then immediately try again to suspend, it works (it does not wake up automatically). Does anyone know what could be going on, and how this can be fixed?

Usually I suspend from my gnome 3 desktop, but I have also tried to suspend directly using 'systemctl suspend' without having an X server running, and the result is exactly the same. I have tried a few versions of the vanilla kernel, but also the linux-lts and the linux-ck images, but to no avail.

Here is the output from dmesg, where suspend fails:

PM: Syncing filesystems ... done.
PM: Preparing system for mem sleep
bbswitch: enabling discrete graphics
Freezing user space processes ... (elapsed 0.543 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
PM: Entering mem sleep
Suspending console(s) (use no_console_suspend to debug)
sd 1:0:0:0: [sda] Synchronizing SCSI cache
smsc75xx 3-1:1.0 enp0s20u1: entering SUSPEND2 mode
sd 1:0:0:0: [sda] Stopping disk
Removing pn544
PM: suspend of devices complete after 334.544 msecs
PM: late suspend of devices complete after 0.201 msecs
ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI
xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
PM: noirq suspend of devices complete after 26.944 msecs
ACPI: Preparing to enter system sleep state S3
PM: Saving platform NVS memory
Disabling non-boot CPUs ...
kvm: disabling virtualization on CPU1
smpboot: CPU 1 is now offline
kvm: disabling virtualization on CPU2
smpboot: CPU 2 is now offline
kvm: disabling virtualization on CPU3
smpboot: CPU 3 is now offline
kvm: disabling virtualization on CPU4
smpboot: CPU 4 is now offline
kvm: disabling virtualization on CPU5
smpboot: CPU 5 is now offline
kvm: disabling virtualization on CPU6
smpboot: CPU 6 is now offline
kvm: disabling virtualization on CPU7
smpboot: CPU 7 is now offline
ACPI: Low-level resume complete
PM: Restoring platform NVS memory
Enabling non-boot CPUs ...
x86: Booting SMP configuration:
smpboot: Booting Node 0 Processor 1 APIC 0x2
kvm: enabling virtualization on CPU1
Intel pstate controlling: cpu 1
CPU1 is up
smpboot: Booting Node 0 Processor 2 APIC 0x4
kvm: enabling virtualization on CPU2
Intel pstate controlling: cpu 2
CPU2 is up
smpboot: Booting Node 0 Processor 3 APIC 0x6
kvm: enabling virtualization on CPU3
Intel pstate controlling: cpu 3
CPU3 is up
smpboot: Booting Node 0 Processor 4 APIC 0x1
kvm: enabling virtualization on CPU4
Intel pstate controlling: cpu 4
CPU4 is up
smpboot: Booting Node 0 Processor 5 APIC 0x3
kvm: enabling virtualization on CPU5
Intel pstate controlling: cpu 5
CPU5 is up
smpboot: Booting Node 0 Processor 6 APIC 0x5
kvm: enabling virtualization on CPU6
Intel pstate controlling: cpu 6
CPU6 is up
smpboot: Booting Node 0 Processor 7 APIC 0x7
kvm: enabling virtualization on CPU7
Intel pstate controlling: cpu 7
CPU7 is up
ACPI: Waking up from system sleep state S3
acpi LNXPOWER:01: Turning OFF
xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI
ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
PM: noirq resume of devices complete after 73.424 msecs
PM: early resume of devices complete after 0.091 msecs
mei_me 0000:00:16.0: irq 49 for MSI/MSI-X
snd_hda_intel 0000:00:03.0: irq 50 for MSI/MSI-X
snd_hda_intel 0000:00:1b.0: irq 53 for MSI/MSI-X
mei_me 0000:00:16.0: NFC MEI VERSION: IVN 0x1 Vendor ID 0x1 Type 0x1
Probing NFC pn544
ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
usb 3-1: reset high-speed USB device number 2 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 1.
ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
ata2.00: configured for UDMA/133
sd 1:0:0:0: [sda] Starting disk
usb 3-1: reset high-speed USB device number 2 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 1.
usb 3-1: reset high-speed USB device number 2 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff88007fd75180
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff88007fd751c0
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff88007fd75200
smsc75xx 3-1:1.0 enp0s20u1: resuming from SUSPEND2
usb 3-4: reset full-speed USB device number 3 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 2.
usb 3-4: reset full-speed USB device number 3 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 2.
usb 3-4: reset full-speed USB device number 3 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9ac0
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9a80
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9a40
usb 3-6: reset full-speed USB device number 4 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 3.
usb 3-6: reset full-speed USB device number 4 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 3.
[drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
usb 3-6: reset full-speed USB device number 4 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804174ddc80
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804174ddcc0
usb 3-11: reset high-speed USB device number 6 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 5.
usb 3-11: reset high-speed USB device number 6 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 5.
usb 3-11: reset high-speed USB device number 6 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9480
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9440
usb 3-9: reset full-speed USB device number 5 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 4.
usb 3-9: reset full-speed USB device number 5 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 4.
pciehp 0000:00:1c.0:pcie04: Link Training Error occurs 
pciehp 0000:00:1c.0:pcie04: Failed to check link status
dpm_run_callback(): pnp_bus_resume+0x0/0xa0 returns -19
PM: Device 00:08 failed to resume: error -19
usb 3-9: reset full-speed USB device number 5 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804181db000
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804181db040
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804181db080
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff880417451e80
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff880417451ec0
PM: resume of devices complete after 2769.054 msecs
PM: Finishing wakeup.
Restarting tasks ... 
iwlwifi 0000:06:00.0: no hotplug settings from platform
rtsx_pci 0000:07:00.0: no hotplug settings from platform
done.
Bluetooth: hci0: read Intel version: 370710018002030d00
Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq
video LNXVIDEO:00: Restoring backlight state
video LNXVIDEO:01: Restoring backlight state
bbswitch: disabling discrete graphics
ACPI Warning: \_SB_.PCI0.PEG0.PEGP._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20131218/nsarguments-95)
Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated
smsc75xx 3-1:1.0 enp0s20u1: link down
smsc75xx 3-1:1.0 enp0s20u1: link down
smsc75xx 3-1:1.0 enp0s20u1: kevent 4 may have been dropped
smsc75xx 3-1:1.0 enp0s20u1: link down
smsc75xx 3-1:1.0 enp0s20u1: link down

and here where suspend succeeds:

smsc75xx 3-1:1.0 enp0s20u1: kevent 4 may have been dropped
smsc75xx 3-1:1.0 enp0s20u1: link up, 100Mbps, full-duplex, lpa 0xC5E1
smsc75xx 3-1:1.0 enp0s20u1: link up, 100Mbps, full-duplex, lpa 0xC5E1
PM: Syncing filesystems ... done.
PM: Preparing system for mem sleep
bbswitch: enabling discrete graphics
Freezing user space processes ... (elapsed 0.412 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
PM: Entering mem sleep
Suspending console(s) (use no_console_suspend to debug)
sd 1:0:0:0: [sda] Synchronizing SCSI cache
smsc75xx 3-1:1.0 enp0s20u1: entering SUSPEND2 mode
sd 1:0:0:0: [sda] Stopping disk
Removing pn544
PM: suspend of devices complete after 780.265 msecs
PM: late suspend of devices complete after 0.387 msecs
ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI
xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
PM: noirq suspend of devices complete after 26.988 msecs
ACPI: Preparing to enter system sleep state S3
PM: Saving platform NVS memory
Disabling non-boot CPUs ...
kvm: disabling virtualization on CPU1
smpboot: CPU 1 is now offline
kvm: disabling virtualization on CPU2
smpboot: CPU 2 is now offline
kvm: disabling virtualization on CPU3
smpboot: CPU 3 is now offline
kvm: disabling virtualization on CPU4
smpboot: CPU 4 is now offline
kvm: disabling virtualization on CPU5
smpboot: CPU 5 is now offline
kvm: disabling virtualization on CPU6
smpboot: CPU 6 is now offline
kvm: disabling virtualization on CPU7
smpboot: CPU 7 is now offline
ACPI: Low-level resume complete
PM: Restoring platform NVS memory
Enabling non-boot CPUs ...
x86: Booting SMP configuration:
smpboot: Booting Node 0 Processor 1 APIC 0x2
kvm: enabling virtualization on CPU1
Intel pstate controlling: cpu 1
CPU1 is up
smpboot: Booting Node 0 Processor 2 APIC 0x4
kvm: enabling virtualization on CPU2
Intel pstate controlling: cpu 2
CPU2 is up
smpboot: Booting Node 0 Processor 3 APIC 0x6
kvm: enabling virtualization on CPU3
Intel pstate controlling: cpu 3
CPU3 is up
smpboot: Booting Node 0 Processor 4 APIC 0x1
kvm: enabling virtualization on CPU4
Intel pstate controlling: cpu 4
CPU4 is up
smpboot: Booting Node 0 Processor 5 APIC 0x3
kvm: enabling virtualization on CPU5
Intel pstate controlling: cpu 5
CPU5 is up
smpboot: Booting Node 0 Processor 6 APIC 0x5
kvm: enabling virtualization on CPU6
Intel pstate controlling: cpu 6
CPU6 is up
smpboot: Booting Node 0 Processor 7 APIC 0x7
kvm: enabling virtualization on CPU7
Intel pstate controlling: cpu 7
CPU7 is up
ACPI: Waking up from system sleep state S3
acpi LNXPOWER:01: Turning OFF
xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI
ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
PM: noirq resume of devices complete after 73.411 msecs
PM: early resume of devices complete after 0.097 msecs
mei_me 0000:00:16.0: irq 49 for MSI/MSI-X
snd_hda_intel 0000:00:03.0: irq 50 for MSI/MSI-X
snd_hda_intel 0000:00:1b.0: irq 53 for MSI/MSI-X
mei_me 0000:00:16.0: NFC MEI VERSION: IVN 0x1 Vendor ID 0x1 Type 0x1
Probing NFC pn544
ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
usb 3-4: reset full-speed USB device number 3 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 2.
ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
ata2.00: configured for UDMA/133
sd 1:0:0:0: [sda] Starting disk
usb 3-4: reset full-speed USB device number 3 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 2.
usb 3-4: reset full-speed USB device number 3 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9ac0
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9a80
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9a40
usb 3-1: reset high-speed USB device number 2 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 1.
usb 3-1: reset high-speed USB device number 2 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 1.
usb 3-1: reset high-speed USB device number 2 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff88007fd75180
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff88007fd751c0
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff88007fd75200
smsc75xx 3-1:1.0 enp0s20u1: resuming from SUSPEND2
usb 3-9: reset full-speed USB device number 5 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 4.
usb 3-9: reset full-speed USB device number 5 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 4.
[drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
usb 3-9: reset full-speed USB device number 5 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804181db000
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804181db040
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804181db080
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff880417451e80
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff880417451ec0
usb 3-6: reset full-speed USB device number 4 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 3.
usb 3-6: reset full-speed USB device number 4 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 3.
usb 3-6: reset full-speed USB device number 4 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804174ddc80
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804174ddcc0
usb 3-11: reset high-speed USB device number 6 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 5.
usb 3-11: reset high-speed USB device number 6 using xhci_hcd
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 5.
pciehp 0000:00:1c.0:pcie04: Link Training Error occurs 
pciehp 0000:00:1c.0:pcie04: Failed to check link status
dpm_run_callback(): pnp_bus_resume+0x0/0xa0 returns -19
PM: Device 00:08 failed to resume: error -19
usb 3-11: reset high-speed USB device number 6 using xhci_hcd
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9480
xhci_hcd 0000:00:14.0: xHCI xhci_drop_endpoint called with disabled ep ffff8804148f9440
PM: resume of devices complete after 2801.389 msecs
PM: Finishing wakeup.
Restarting tasks ... 
iwlwifi 0000:06:00.0: no hotplug settings from platform
rtsx_pci 0000:07:00.0: no hotplug settings from platform
done.
Bluetooth: hci0: read Intel version: 370710018002030d00
Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq
video LNXVIDEO:00: Restoring backlight state
video LNXVIDEO:01: Restoring backlight state
bbswitch: disabling discrete graphics
ACPI Warning: \_SB_.PCI0.PEG0.PEGP._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20131218/nsarguments-95)
Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated
systemd[1]: Requested transaction contradicts existing jobs: File exists
systemd[1]: Service sleep.target is not needed anymore. Stopping.
smsc75xx 3-1:1.0 enp0s20u1: kevent 4 may have been dropped
smsc75xx 3-1:1.0 enp0s20u1: link down
smsc75xx 3-1:1.0 enp0s20u1: link down

It seems to me like the only real difference has to do with the xhci_hcd errors, perhaps the following:
xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 2.

Any input or help would be highly appreciated.

Rexilion

Member

Registered: 2013-12-23

Posts: 784

Re: Suspends fails the first time, but succeeds the second time

Maybe you could confirm your suspicion by rmmoding xhci before suspend and modprobing it after resume?

---

fs/super.c : "Self-destruct in 5 seconds.  Have a nice day...\n",

siggiae

Member

Registered: 2009-02-24

Posts: 8

Re: Suspends fails the first time, but succeeds the second time

Maybe you could confirm your suspicion by rmmoding xhci before suspend and modprobing it after resume?

Thanks for the response. I should have said so, but I had already tried that, but without any luck. It seems like it doesn't change anything.

Axinorm

Member

Registered: 2014-04-22

Posts: 5

Re: Suspends fails the first time, but succeeds the second time

I have the same problem with a DELL XPS 15z...

lkraav

Member

Registered: 2011-04-08

Posts: 39

Re: Suspends fails the first time, but succeeds the second time

Google /proc/acpi/wakeup

siggiae

Member

Registered: 2009-02-24

Posts: 8

Re: Suspends fails the first time, but succeeds the second time

Thanks for the hint Ikraav.  I tried to disable all the entries under /proc/acpi/wakup (except PWRB), but it didn't help. I however think I have solved the problem. Disabling both Intel Rapid Start and Intel Smart Connect seems to do the trick.