Scheduled Maintenance: We are aware of an issue with Google, AOL, and Yahoo services as email providers which are blocking new registrations. We are trying to fix the issue and we have several internal and external support tickets in process to resolve the issue. Please see: viewtopic.php?t=158230

 

 

 

[SOLVED] Immediate resume from suspend on Thinkpad (S1) Yoga

Linux Kernel, Network, and Services configuration.
Post Reply
Message
Author
j1ntr0
Posts: 2
Joined: 2017-06-20 11:40

[SOLVED] Immediate resume from suspend on Thinkpad (S1) Yoga

#1 Post by j1ntr0 »

Hello everyone,

After upgrading to Stretch, my laptop wakes immediately after entering suspend. I'm on a Lenovo Thinkpad Yoga S1 (the 20CD model).

I found someone who had the same problem in 2015 after upgrading to Fedora 23 from 22, who had the following fix:
If I disable this with

Code: Select all

echo XHC >/proc/acpi/wakeup
the problem goes away.
Presumably this is disabling XHCI (usb-3) wakeup.
source: https://bugzilla.redhat.com/show_bug.cgi?id=1286268

I did this, and it worked (although I did it with nano instead of echo, as echo complained of insufficient privileges, even when using sudo).
But this was no issue under Jessie, and I'd rather fix the underlying problem instead of using a workaround that might introduce new problems of its own.
Also I have no idea what disabling XHC in /proc/acpi/wakeup precisely does.

I've run two test scenarios, one where the XHC line is disabled and when it's enabled. When disabled, suspend works properly. When enabled, the computer immediately wakes up again (with the lid still shut). Here follow the relevant lines from /var/log/syslog:

XHC disabled, suspend succesful:

Code: Select all

Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2078] manager: sleep requested (sleeping: no  enabled: yes)
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2079] manager: sleeping...
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2079] manager: NetworkManager state is now ASLEEP
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2082] device (wlan0): state change: activated -> deactivating (reason 'sleeping') [100 110 37]
Jun 20 15:13:31 flaptop dbus[461]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Jun 20 15:13:31 flaptop org.gnome.Shell.desktop[992]: Window manager warning: Failed to set power save mode for output eDP-1: Permission denied
Jun 20 15:13:31 flaptop systemd[1]: Starting Network Manager Script Dispatcher Service...
Jun 20 15:13:31 flaptop dbus[461]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jun 20 15:13:31 flaptop systemd[1]: Started Network Manager Script Dispatcher Service.
Jun 20 15:13:31 flaptop nm-dispatcher: req:1 'connectivity-change': new request (1 scripts)
Jun 20 15:13:31 flaptop nm-dispatcher: req:1 'connectivity-change': start running ordered scripts...
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2281] device (wlan0): state change: deactivating -> disconnected (reason 'sleeping') [110 30 37]
Jun 20 15:13:31 flaptop avahi-daemon[454]: Withdrawing address record for fe80::b079:5155:c916:ae08 on wlan0.
Jun 20 15:13:31 flaptop avahi-daemon[454]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::b079:5155:c916:ae08.
Jun 20 15:13:31 flaptop avahi-daemon[454]: Interface wlan0.IPv6 no longer relevant for mDNS.
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2475] dhcp4 (wlan0): canceled DHCP transaction, DHCP client pid 7764
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2476] dhcp4 (wlan0): state changed bound -> done
Jun 20 15:13:31 flaptop avahi-daemon[454]: Withdrawing address record for 192.168.0.189 on wlan0.
Jun 20 15:13:31 flaptop avahi-daemon[454]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.189.
Jun 20 15:13:31 flaptop kernel: [43496.035431] wlan0: deauthenticating from e4:f4:c6:e0:bd:6f by local choice (Reason: 3=DEAUTH_LEAVING)
Jun 20 15:13:31 flaptop kernel: [43496.043325] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jun 20 15:13:31 flaptop wpa_supplicant[580]: wlan0: CTRL-EVENT-DISCONNECTED bssid=e4:f4:c6:e0:bd:6f reason=3 locally_generated=1
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2551] device (wlan0): set-hw-addr: set MAC address to FA:BF:AC:88:E3:BE (scanning)
Jun 20 15:13:31 flaptop avahi-daemon[454]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jun 20 15:13:31 flaptop nm-dispatcher: req:2 'down' [wlan0]: new request (1 scripts)
Jun 20 15:13:31 flaptop nm-dispatcher: req:2 'down' [wlan0]: start running ordered scripts...
Jun 20 15:13:31 flaptop wpa_supplicant[580]: p2p-dev-wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jun 20 15:13:31 flaptop NetworkManager[479]: <warn>  [1497964411.2708] sup-iface[0x55dd696c9e80,wlan0]: connection disconnected (reason -3)
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2710] device (wlan0): supplicant interface state: completed -> disconnected
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2744] device (wlan0): state change: disconnected -> unmanaged (reason 'sleeping') [30 10 37]
Jun 20 15:13:31 flaptop NetworkManager[479]: <info>  [1497964411.2760] device (wlan0): set-hw-addr: reset MAC address to 0C:8B:FD:CB:C4:1F (unmanage)
Jun 20 15:13:31 flaptop wpa_supplicant[580]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0281 Gs  no app for changed redshift@tommie-lie.de
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0283 Gs  no app for changed alternate-tab@gnome-shell-extensions.gcampax.github.com
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0284 Gs  no app for changed battery_status@milliburn.github.com
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0285 Gs  no app for changed refresh-wifi@kgshank.net
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0288 Gs  no app for changed nohotcorner@azuri.free.fr
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0289 Gs  no app for changed sound-output-device-chooser@kgshank.net
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0303 Gs  no app for changed places-menu@gnome-shell-extensions.gcampax.github.com
Jun 20 15:13:31 flaptop gnome-software-service.desktop[1344]: 13:13:31:0304 Gs  no app for changed launch-new-instance@gnome-shell-extensions.gcampax.github.com
Jun 20 15:13:31 flaptop wpa_supplicant[580]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Jun 20 15:13:33 flaptop goa-daemon[1254]: secret_password_lookup_sync() returned NULL
Jun 20 15:13:34 flaptop systemd[1]: Reached target Sleep.
Jun 20 15:13:34 flaptop systemd[1]: Starting Suspend...
Jun 20 15:13:34 flaptop systemd-sleep[8233]: Suspending system...

waited one minute...

Jun 20 15:14:31 flaptop kernel: [43499.500171] PM: Syncing filesystems ... done.
Jun 20 15:14:31 flaptop kernel: [43499.523575] PM: Preparing system for sleep (mem)
Jun 20 15:14:31 flaptop kernel: [43499.523813] (NULL device *): firmware: direct-loading firmware intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq
Jun 20 15:14:31 flaptop kernel: [43499.523992] (NULL device *): firmware: direct-loading firmware iwlwifi-7260-17.ucode
Jun 20 15:14:31 flaptop kernel: [43499.524001] Freezing user space processes ... (elapsed 0.001 seconds) done.
Jun 20 15:14:31 flaptop kernel: [43499.525887] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Jun 20 15:14:31 flaptop kernel: [43499.527103] PM: Suspending system (mem)
Jun 20 15:14:31 flaptop kernel: [43499.527135] Suspending console(s) (use no_console_suspend to debug)
Jun 20 15:14:31 flaptop kernel: [43499.699910] sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jun 20 15:14:31 flaptop kernel: [43499.704481] sd 0:0:0:0: [sda] Stopping disk
Jun 20 15:14:31 flaptop kernel: [43499.754809] ACPI : EC: event blocked
Jun 20 15:14:31 flaptop kernel: [43500.376954] PM: suspend of devices complete after 849.796 msecs
Jun 20 15:14:31 flaptop kernel: [43500.396637] PM: late suspend of devices complete after 19.682 msecs
Jun 20 15:14:31 flaptop kernel: [43500.397094] ACPI : EC: interrupt blocked
Jun 20 15:14:31 flaptop kernel: [43500.436621] PM: noirq suspend of devices complete after 39.986 msecs
Jun 20 15:14:31 flaptop kernel: [43500.437058] ACPI: Preparing to enter system sleep state S3
Jun 20 15:14:31 flaptop kernel: [43500.439682] ACPI : EC: EC stopped
Jun 20 15:14:31 flaptop kernel: [43500.439682] PM: Saving platform NVS memory
Jun 20 15:14:31 flaptop kernel: [43500.439693] Disabling non-boot CPUs ...
Jun 20 15:14:31 flaptop kernel: [43500.439911] Broke affinity for irq 23
Jun 20 15:14:31 flaptop kernel: [43500.439914] Broke affinity for irq 42
Jun 20 15:14:31 flaptop kernel: [43500.439915] Broke affinity for irq 45
Jun 20 15:14:31 flaptop kernel: [43500.440930] smpboot: CPU 1 is now offline
Jun 20 15:14:31 flaptop kernel: [43500.441458] Broke affinity for irq 23
Jun 20 15:14:31 flaptop kernel: [43500.441462] Broke affinity for irq 42
Jun 20 15:14:31 flaptop kernel: [43500.441464] Broke affinity for irq 45
Jun 20 15:14:31 flaptop kernel: [43500.442771] smpboot: CPU 2 is now offline
Jun 20 15:14:31 flaptop kernel: [43500.443253] Broke affinity for irq 1
Jun 20 15:14:31 flaptop kernel: [43500.443264] Broke affinity for irq 9
Jun 20 15:14:31 flaptop kernel: [43500.443269] Broke affinity for irq 12
Jun 20 15:14:31 flaptop kernel: [43500.443279] Broke affinity for irq 23
Jun 20 15:14:31 flaptop kernel: [43500.443285] Broke affinity for irq 41
Jun 20 15:14:31 flaptop kernel: [43500.443287] Broke affinity for irq 42
Jun 20 15:14:31 flaptop kernel: [43500.443290] Broke affinity for irq 45
Jun 20 15:14:31 flaptop kernel: [43500.443293] Broke affinity for irq 46
Jun 20 15:14:31 flaptop kernel: [43500.444327] smpboot: CPU 3 is now offline
Jun 20 15:14:31 flaptop kernel: [43500.447281] ACPI: Low-level resume complete
Jun 20 15:14:31 flaptop kernel: [43500.447359] ACPI : EC: EC started
Jun 20 15:14:31 flaptop kernel: [43500.447359] PM: Restoring platform NVS memory
Jun 20 15:14:31 flaptop kernel: [43500.447697] Suspended for 54.803 seconds
Jun 20 15:14:31 flaptop kernel: [43500.447762] Enabling non-boot CPUs ...
Jun 20 15:14:31 flaptop kernel: [43500.447844] x86: Booting SMP configuration:
Jun 20 15:14:31 flaptop kernel: [43500.447845] smpboot: Booting Node 0 Processor 1 APIC 0x1
Jun 20 15:14:31 flaptop kernel: [43500.450729]  cache: parent cpu1 should not be sleeping
Jun 20 15:14:31 flaptop kernel: [43500.451001] CPU1 is up
Jun 20 15:14:31 flaptop kernel: [43500.451079] smpboot: Booting Node 0 Processor 2 APIC 0x2
Jun 20 15:14:31 flaptop kernel: [43500.453754]  cache: parent cpu2 should not be sleeping
Jun 20 15:14:31 flaptop kernel: [43500.454069] CPU2 is up
Jun 20 15:14:31 flaptop kernel: [43500.454131] smpboot: Booting Node 0 Processor 3 APIC 0x3
Jun 20 15:14:31 flaptop kernel: [43500.456895]  cache: parent cpu3 should not be sleeping
Jun 20 15:14:31 flaptop kernel: [43500.457216] CPU3 is up
Jun 20 15:14:31 flaptop kernel: [43500.462382] ACPI: Waking up from system sleep state S3
Jun 20 15:14:31 flaptop kernel: [43500.607692] ACPI : EC: interrupt unblocked
Jun 20 15:14:31 flaptop kernel: [43500.739412] PM: noirq resume of devices complete after 131.905 msecs
Jun 20 15:14:31 flaptop kernel: [43500.740089] PM: early resume of devices complete after 0.632 msecs
Jun 20 15:14:31 flaptop kernel: [43500.740295] ACPI : EC: event unblocked
Jun 20 15:14:31 flaptop kernel: [43500.740978] rtc_cmos 00:01: System wakeup disabled by ACPI
Jun 20 15:14:31 flaptop kernel: [43500.743335] sd 0:0:0:0: [sda] Starting disk
Jun 20 15:14:31 flaptop kernel: [43500.803994] xhci_hcd 0000:00:14.0: port 4 resume PLC timeout
Jun 20 15:14:31 flaptop kernel: [43500.820733] xhci_hcd 0000:00:14.0: port 3 resume PLC timeout
Jun 20 15:14:31 flaptop kernel: [43500.887332] usb 3-1.7: reset full-speed USB device number 3 using ehci-pci
Jun 20 15:14:31 flaptop kernel: [43501.054076] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jun 20 15:14:31 flaptop kernel: [43501.057001] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:14:31 flaptop kernel: [43501.057003] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Jun 20 15:14:31 flaptop kernel: [43501.057065] ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:14:31 flaptop kernel: [43501.057212] ata1.00: supports DRM functions and may not be fully accessible
Jun 20 15:14:31 flaptop kernel: [43501.059486] usb 1-4: reset full-speed USB device number 3 using xhci_hcd
Jun 20 15:14:31 flaptop kernel: [43501.062298] ata1.00: NCQ Send/Recv Log not supported
Jun 20 15:14:31 flaptop kernel: [43501.062651] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:14:31 flaptop kernel: [43501.062653] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Jun 20 15:14:31 flaptop kernel: [43501.062675] ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:14:31 flaptop kernel: [43501.062799] ata1.00: supports DRM functions and may not be fully accessible
Jun 20 15:14:31 flaptop kernel: [43501.062866] ata1.00: NCQ Send/Recv Log not supported
Jun 20 15:14:31 flaptop kernel: [43501.062928] ata1.00: configured for UDMA/133
Jun 20 15:14:31 flaptop kernel: [43501.075304] usb 3-1.8: reset full-speed USB device number 10 using ehci-pci
Jun 20 15:14:31 flaptop kernel: [43501.313587] psmouse serio1: synaptics: queried max coordinates: x [..5710], y [..4696]
Jun 20 15:14:31 flaptop kernel: [43501.319369] usb 1-6: reset high-speed USB device number 5 using xhci_hcd
Jun 20 15:14:31 flaptop kernel: [43501.358361] psmouse serio1: synaptics: queried min coordinates: x [1232..], y [1156..]
Jun 20 15:14:31 flaptop kernel: [43501.358379] psmouse serio1: synaptics: quirked min/max coordinates: x [1232..5710], y [1156..4696]
Jun 20 15:14:31 flaptop kernel: [43501.579416] usb 1-5: reset full-speed USB device number 4 using xhci_hcd
Jun 20 15:14:31 flaptop kernel: [43501.725923] PM: resume of devices complete after 985.960 msecs
Jun 20 15:14:31 flaptop kernel: [43501.726006] usb 1-4:1.0: rebind failed: -517
Jun 20 15:14:31 flaptop kernel: [43501.726018] usb 1-4:1.1: rebind failed: -517
Jun 20 15:14:31 flaptop kernel: [43501.726337] PM: Finishing wakeup.
Jun 20 15:14:31 flaptop kernel: [43501.726338] Restarting tasks ... done.
XHC enabled, suspend unsuccesful:

Code: Select all

Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1318] manager: sleep requested (sleeping: no  enabled: yes)
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1318] manager: sleeping...
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1319] manager: NetworkManager state is now ASLEEP
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1322] device (wlan0): state change: activated -> deactivating (reason 'sleeping') [100 110 37]
Jun 20 15:34:33 flaptop dbus[461]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Jun 20 15:34:33 flaptop systemd[1]: Starting Network Manager Script Dispatcher Service...
Jun 20 15:34:33 flaptop org.gnome.Shell.desktop[992]: Window manager warning: Failed to set power save mode for output eDP-1: Permission denied
Jun 20 15:34:33 flaptop dbus[461]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jun 20 15:34:33 flaptop systemd[1]: Started Network Manager Script Dispatcher Service.
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1540] device (wlan0): state change: deactivating -> disconnected (reason 'sleeping') [110 30 37]
Jun 20 15:34:33 flaptop avahi-daemon[454]: Withdrawing address record for fe80::b079:5155:c916:ae08 on wlan0.
Jun 20 15:34:33 flaptop avahi-daemon[454]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::b079:5155:c916:ae08.
Jun 20 15:34:33 flaptop avahi-daemon[454]: Interface wlan0.IPv6 no longer relevant for mDNS.
Jun 20 15:34:33 flaptop nm-dispatcher: req:1 'connectivity-change': new request (1 scripts)
Jun 20 15:34:33 flaptop nm-dispatcher: req:1 'connectivity-change': start running ordered scripts...
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1878] dhcp4 (wlan0): canceled DHCP transaction, DHCP client pid 8301
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1878] dhcp4 (wlan0): state changed bound -> done
Jun 20 15:34:33 flaptop avahi-daemon[454]: Withdrawing address record for 192.168.0.189 on wlan0.
Jun 20 15:34:33 flaptop avahi-daemon[454]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.189.
Jun 20 15:34:33 flaptop kernel: [44702.870459] wlan0: deauthenticating from e4:f4:c6:e0:bd:6f by local choice (Reason: 3=DEAUTH_LEAVING)
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.1941] device (wlan0): set-hw-addr: set MAC address to 4A:06:03:6C:B0:94 (scanning)
Jun 20 15:34:33 flaptop avahi-daemon[454]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jun 20 15:34:33 flaptop kernel: [44702.877813] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jun 20 15:34:33 flaptop wpa_supplicant[580]: wlan0: CTRL-EVENT-DISCONNECTED bssid=e4:f4:c6:e0:bd:6f reason=3 locally_generated=1
Jun 20 15:34:33 flaptop nm-dispatcher: req:2 'down' [wlan0]: new request (1 scripts)
Jun 20 15:34:33 flaptop nm-dispatcher: req:2 'down' [wlan0]: start running ordered scripts...
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0209 Gs  no app for changed redshift@tommie-lie.de
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0212 Gs  no app for changed alternate-tab@gnome-shell-extensions.gcampax.github.com
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0213 Gs  no app for changed battery_status@milliburn.github.com
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0215 Gs  no app for changed refresh-wifi@kgshank.net
Jun 20 15:34:33 flaptop NetworkManager[479]: <warn>  [1497965673.2168] sup-iface[0x55dd69637530,wlan0]: connection disconnected (reason -3)
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0217 Gs  no app for changed nohotcorner@azuri.free.fr
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.2170] device (wlan0): supplicant interface state: completed -> disconnected
Jun 20 15:34:33 flaptop NetworkManager[479]: <warn>  [1497965673.2171] sup-iface[0x55dd69637530,wlan0]: connection disconnected (reason -3)
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0219 Gs  no app for changed sound-output-device-chooser@kgshank.net
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.2229] device (wlan0): state change: disconnected -> unmanaged (reason 'sleeping') [30 10 37]
Jun 20 15:34:33 flaptop wpa_supplicant[580]: p2p-dev-wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jun 20 15:34:33 flaptop NetworkManager[479]: <info>  [1497965673.2247] device (wlan0): set-hw-addr: reset MAC address to 0C:8B:FD:CB:C4:1F (unmanage)
Jun 20 15:34:33 flaptop wpa_supplicant[580]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0232 Gs  no app for changed places-menu@gnome-shell-extensions.gcampax.github.com
Jun 20 15:34:33 flaptop gnome-software-service.desktop[1344]: 13:34:33:0234 Gs  no app for changed launch-new-instance@gnome-shell-extensions.gcampax.github.com
Jun 20 15:34:33 flaptop wpa_supplicant[580]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Jun 20 15:34:35 flaptop goa-daemon[1254]: secret_password_lookup_sync() returned NULL
Jun 20 15:34:36 flaptop systemd[1]: Reached target Sleep.
Jun 20 15:34:36 flaptop systemd[1]: Starting Suspend...
Jun 20 15:34:36 flaptop systemd-sleep[9437]: Suspending system...
Jun 20 15:34:41 flaptop kernel: [44706.204437] PM: Syncing filesystems ... done.
Jun 20 15:34:41 flaptop kernel: [44706.226957] PM: Preparing system for sleep (mem)
Jun 20 15:34:41 flaptop kernel: [44706.227359] (NULL device *): firmware: direct-loading firmware iwlwifi-7260-17.ucode
Jun 20 15:34:41 flaptop kernel: [44706.227370] Freezing user space processes ... (elapsed 0.001 seconds) done.
Jun 20 15:34:41 flaptop kernel: [44706.229305] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Jun 20 15:34:41 flaptop kernel: [44706.230564] PM: Suspending system (mem)
Jun 20 15:34:41 flaptop kernel: [44706.230598] Suspending console(s) (use no_console_suspend to debug)
Jun 20 15:34:41 flaptop kernel: [44706.399720] sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jun 20 15:34:41 flaptop kernel: [44706.402885] sd 0:0:0:0: [sda] Stopping disk
Jun 20 15:34:41 flaptop kernel: [44706.457867] ACPI : EC: event blocked
Jun 20 15:34:41 flaptop kernel: [44707.404461] PM: suspend of devices complete after 1173.817 msecs
Jun 20 15:34:41 flaptop kernel: [44707.424041] PM: late suspend of devices complete after 19.574 msecs
Jun 20 15:34:41 flaptop kernel: [44707.424678] ACPI : EC: interrupt blocked
Jun 20 15:34:41 flaptop kernel: [44707.425396] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
Jun 20 15:34:41 flaptop kernel: [44707.463966] PM: noirq suspend of devices complete after 39.924 msecs
Jun 20 15:34:41 flaptop kernel: [44707.464679] ACPI: Preparing to enter system sleep state S3
Jun 20 15:34:41 flaptop kernel: [44707.468075] ACPI : EC: EC stopped
Jun 20 15:34:41 flaptop kernel: [44707.468076] PM: Saving platform NVS memory
Jun 20 15:34:41 flaptop kernel: [44707.468092] Disabling non-boot CPUs ...
Jun 20 15:34:41 flaptop kernel: [44707.468452] Broke affinity for irq 23
Jun 20 15:34:41 flaptop kernel: [44707.468458] Broke affinity for irq 42
Jun 20 15:34:41 flaptop kernel: [44707.469997] smpboot: CPU 1 is now offline
Jun 20 15:34:41 flaptop kernel: [44707.470721] Broke affinity for irq 23
Jun 20 15:34:41 flaptop kernel: [44707.470728] Broke affinity for irq 42
Jun 20 15:34:41 flaptop kernel: [44707.470731] Broke affinity for irq 45
Jun 20 15:34:41 flaptop kernel: [44707.471758] smpboot: CPU 2 is now offline
Jun 20 15:34:41 flaptop kernel: [44707.472627] Broke affinity for irq 1
Jun 20 15:34:41 flaptop kernel: [44707.472636] Broke affinity for irq 9
Jun 20 15:34:41 flaptop kernel: [44707.472641] Broke affinity for irq 12
Jun 20 15:34:41 flaptop kernel: [44707.472651] Broke affinity for irq 23
Jun 20 15:34:41 flaptop kernel: [44707.472655] Broke affinity for irq 41
Jun 20 15:34:41 flaptop kernel: [44707.472658] Broke affinity for irq 42
Jun 20 15:34:41 flaptop kernel: [44707.472660] Broke affinity for irq 45
Jun 20 15:34:41 flaptop kernel: [44707.472662] Broke affinity for irq 46
Jun 20 15:34:41 flaptop kernel: [44707.473680] smpboot: CPU 3 is now offline
Jun 20 15:34:41 flaptop kernel: [44707.476231] ACPI: Low-level resume complete
Jun 20 15:34:41 flaptop kernel: [44707.476308] ACPI : EC: EC started
Jun 20 15:34:41 flaptop kernel: [44707.476308] PM: Restoring platform NVS memory
Jun 20 15:34:41 flaptop kernel: [44707.476648] Suspended for 2.670 seconds
Jun 20 15:34:41 flaptop kernel: [44707.476712] Enabling non-boot CPUs ...
Jun 20 15:34:41 flaptop kernel: [44707.476794] x86: Booting SMP configuration:
Jun 20 15:34:41 flaptop kernel: [44707.476795] smpboot: Booting Node 0 Processor 1 APIC 0x1
Jun 20 15:34:41 flaptop kernel: [44707.479653]  cache: parent cpu1 should not be sleeping
Jun 20 15:34:41 flaptop kernel: [44707.479915] CPU1 is up
Jun 20 15:34:41 flaptop kernel: [44707.479993] smpboot: Booting Node 0 Processor 2 APIC 0x2
Jun 20 15:34:41 flaptop kernel: [44707.482645]  cache: parent cpu2 should not be sleeping
Jun 20 15:34:41 flaptop kernel: [44707.482941] CPU2 is up
Jun 20 15:34:41 flaptop kernel: [44707.483001] smpboot: Booting Node 0 Processor 3 APIC 0x3
Jun 20 15:34:41 flaptop kernel: [44707.485742]  cache: parent cpu3 should not be sleeping
Jun 20 15:34:41 flaptop kernel: [44707.486210] CPU3 is up
Jun 20 15:34:41 flaptop kernel: [44707.496765] ACPI: Waking up from system sleep state S3
Jun 20 15:34:41 flaptop kernel: [44707.642703] ACPI : EC: interrupt unblocked
Jun 20 15:34:41 flaptop kernel: [44707.774382] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
Jun 20 15:34:41 flaptop kernel: [44707.774481] PM: noirq resume of devices complete after 131.923 msecs
Jun 20 15:34:41 flaptop kernel: [44707.775185] PM: early resume of devices complete after 0.666 msecs
Jun 20 15:34:41 flaptop kernel: [44707.775381] ACPI : EC: event unblocked
Jun 20 15:34:41 flaptop kernel: [44707.776207] sd 0:0:0:0: [sda] Starting disk
Jun 20 15:34:41 flaptop kernel: [44707.776383] rtc_cmos 00:01: System wakeup disabled by ACPI
Jun 20 15:34:41 flaptop kernel: [44707.839085] xhci_hcd 0000:00:14.0: port 4 resume PLC timeout
Jun 20 15:34:41 flaptop kernel: [44707.855484] xhci_hcd 0000:00:14.0: port 3 resume PLC timeout
Jun 20 15:34:41 flaptop kernel: [44707.942328] usb 3-1.7: reset full-speed USB device number 3 using ehci-pci
Jun 20 15:34:41 flaptop kernel: [44708.089102] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jun 20 15:34:41 flaptop kernel: [44708.091773] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:34:41 flaptop kernel: [44708.091775] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Jun 20 15:34:41 flaptop kernel: [44708.091852] ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:34:41 flaptop kernel: [44708.092048] ata1.00: supports DRM functions and may not be fully accessible
Jun 20 15:34:41 flaptop kernel: [44708.094489] usb 1-5: reset full-speed USB device number 4 using xhci_hcd
Jun 20 15:34:41 flaptop kernel: [44708.097010] ata1.00: NCQ Send/Recv Log not supported
Jun 20 15:34:41 flaptop kernel: [44708.097417] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:34:41 flaptop kernel: [44708.097419] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Jun 20 15:34:41 flaptop kernel: [44708.097483] ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Jun 20 15:34:41 flaptop kernel: [44708.097667] ata1.00: supports DRM functions and may not be fully accessible
Jun 20 15:34:41 flaptop kernel: [44708.097777] ata1.00: NCQ Send/Recv Log not supported
Jun 20 15:34:41 flaptop kernel: [44708.097839] ata1.00: configured for UDMA/133
Jun 20 15:34:41 flaptop kernel: [44708.130345] usb 3-1.8: reset full-speed USB device number 10 using ehci-pci
Jun 20 15:34:41 flaptop kernel: [44708.304313] psmouse serio1: synaptics: queried max coordinates: x [..5710], y [..4696]
Jun 20 15:34:41 flaptop kernel: [44708.346318] psmouse serio1: synaptics: queried min coordinates: x [1232..], y [1156..]
Jun 20 15:34:41 flaptop kernel: [44708.346322] psmouse serio1: synaptics: quirked min/max coordinates: x [1232..5710], y [1156..4696]
Jun 20 15:34:41 flaptop kernel: [44708.354451] usb 1-4: reset full-speed USB device number 3 using xhci_hcd
Jun 20 15:34:41 flaptop kernel: [44708.614496] usb 1-6: reset high-speed USB device number 5 using xhci_hcd
Jun 20 15:34:41 flaptop kernel: [44708.766338] PM: resume of devices complete after 991.235 msecs
Jun 20 15:34:41 flaptop kernel: [44708.766398] usb 1-4:1.0: rebind failed: -517
Jun 20 15:34:41 flaptop kernel: [44708.766407] usb 1-4:1.1: rebind failed: -517
Jun 20 15:34:41 flaptop kernel: [44708.766646] PM: Finishing wakeup.
Jun 20 15:34:41 flaptop kernel: [44708.766648] Restarting tasks ... done.
Thanks in advance for taking a look!
Regards
Last edited by j1ntr0 on 2017-07-02 17:25, edited 1 time in total.
Top
User avatar
orythem27
Posts: 252
Joined: 2017-05-11 07:59
Location: P.R. China

Re: Immediate resume from suspend on Lenovo Thinkpad (S1) Yo

#2 Post by orythem27 »

j1ntr0 wrote:Also I have no idea what disabling XHC in /proc/acpi/wakeup precisely does.
Check this: https://bugzilla.kernel.org/show_bug.cgi?id=62611#c8
So it means that after disabling XHC wakeup, you cannot wake up the computer by moving a mouse plugged into a USB3 port.
j1ntr0 wrote:(although I did it with nano instead of echo, as echo complained of insufficient privileges, even when using sudo).
As a sidenote, you probably would like to use any of the following commands since redirection is done by the shell which does not have sufficient privileges.

Code: Select all

echo XHC | sudo tee /proc/acpi/wakeup
sudo sh -c "echo XHC >/proc/acpi/wakeup"
j1ntr0 wrote:But this was no issue under Jessie, and I'd rather fix the underlying problem instead of using a workaround that might introduce new problems of its own.
I cannot comment further on this issue, but I guess a kernel developer or a Lenovo staff would be in a better position to understand the underlying problem.
Top
j1ntr0
Posts: 2
Joined: 2017-06-20 11:40

Re: Immediate resume from suspend on Lenovo Thinkpad (S1) Yo

#3 Post by j1ntr0 »

Thanks, that already helps. I read the article on hibernation e.d. on the Arch wiki, where they said the following:
None of this will persist between boots, so you might want to add the echo command to /etc/rc.local so it is executed on every boot:
source: https://wiki.archlinux.org/index.php/Hi ... ing_wakeup

I don't think the shell redirection (and therefore failure because of insufficient privileges) happens when I put the echo XHC >/proc/acpi/wakeup line in there, will it?

Until someone more knowledgeable weighs in on this topic, this will probably be the best solution.

Thanks!
Top
Post Reply

Return to “System and Network configuration”