suspend issues: faulty lid switch?

classic Classic list List threaded Threaded
6 messages Options
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

suspend issues: faulty lid switch?

Matt Price
Hi everyone,

I'm new to the group but have been using Thinkpads for a long time. I'm currently running a GNOME desktop with Arch Linux on a T440s, and a longstanding intermittent problem with suspend has become much much worse in the last few months.

In the past, I had occasional issues where my laptop would fail to wake from suspend, andn eeded to be "hard" reset with the reset button (hte pinhole on the bototm of hte laptop). Since there's an internal battery, I also had to take apart the laptop and disconnect the battery for the reset to work.  At first this happened about once a month; when it became more frequent, about once a week, I diconnected the internal battery completely to make this easier. 

I also have another problem, which may or may not be entirely distinct: the lid suspend switch is loose, and when I adjust my screen angle it will sometimes trigger a suspend event. 

Lately the failure to resume has become much more frequent, so that it now happens at least once a day.  Looking at my logs, it looks like there are someimes many, many lid open/close evnets reported in a single suspend cycle. So for instance, at the end of the email I've posted a snippet of journalctl -b -1, from a syspend cycle which ended in a resume failure. It's several hundred lines long (I'm sorry if that breaches etiquette, pleasee tell me if I should do osmething else), and you can see a ocuple of other htings happening, like stack traces of a crash in bluetooth. The main thing I notice, though, is many "lid opened" "lid closed" events repeated in rapid succession. I'm wondering if there's a race condition that ends up causing some of hte resume fialures.  I've even seen htings in the log like an apparent wakeup 15 or 30 minutes after a successful suspend, followed by another suspend cycle some time later.

So I guess my questions are:

- am I right that this kind of log activity is irregular?
- is there a way to physically fix the lid switch?
- if not, do you know of a way ot disable the switch entirely? Is that handled maybe in /etc/systemd/logind.conf?
- do you see any evidence of another problem that I'm missing?
- is there anywhere else I should look for information about suspend/resume issues?

Thanks in advance for your help!
Matt

------------------
Sep 03 21:30:51 osskil systemd[1]: Started Hybrid Suspend+Hibernate.
Sep 03 21:30:51 osskil systemd[1]: sleep.target: Unit not needed anymore. Stopping.
Sep 03 21:30:51 osskil systemd[1]: Stopped target Sleep.
Sep 03 21:30:51 osskil systemd[1]: Reached target Hybrid Suspend+Hibernate.
Sep 03 21:30:51 osskil systemd-logind[643]: Operation 'sleep' finished.
Sep 03 21:30:51 osskil systemd[1]: hybrid-sleep.target: Unit is bound to inactive unit systemd-hybrid-sleep.service. Stopping, too.
Sep 03 21:30:51 osskil systemd[1]: Stopped target Hybrid Suspend+Hibernate.
Sep 03 21:30:51 osskil NetworkManager[649]: <info>  [1472952651.6767] manager: wake requested (sleeping: yes  enabled: yes)
Sep 03 21:30:51 osskil NetworkManager[649]: <info>  [1472952651.6767] manager: waking up...
Sep 03 21:30:51 osskil NetworkManager[649]: <info>  [1472952651.6768] device (enp0s25): state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37]
Sep 03 21:30:51 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to set power save mode for output eDP37: Permission denied
Sep 03 21:30:51 osskil kernel: Process accounting resumed
Sep 03 21:30:51 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:51 osskil systemd-logind[643]: Hibernating and suspending...
Sep 03 21:30:51 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:51 osskil org .gnome.Shell.desktop[715]: Window manager warning: Failed to set power save mode for output eDP37: Permission denied
Sep 03 21:30:51 osskil kernel: e1000e: enp0s25 NIC Link is Down
Sep 03 21:30:51 osskil NetworkManager[649]: <info>  [1472952651.7853] device (enp0s25): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 03 21:30:51 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Sep 03 21:30:51 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:51 osskil NetworkManager[649]: <info>  [1472952651.9929] device (wlp3s0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 03 21:30:51 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Sep 03 21:30:51 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:30:51 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:51 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.2456] device (wlp3s0): set-hw-addr: set MAC address to 4E:93:C0:DC:6A:F8 (scanning)
Sep 03 21:30:52 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:52 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:52 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:52 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:30:52 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:52 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.4808] manager: NetworkManager state is now DISCONNECTED
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.4812] manager: sleep requested (sleeping: no  enabled: yes)
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.4813] manager: sleeping...
Sep 03 21:30:52 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.4813] device (wlp3s0): state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37]
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.4911] device (wlp3s0): set-hw-addr: reset MAC address to 5C:51:4F:4E:17:95 (unmanage)
Sep 03 21:30:52 osskil NetworkManager[649]: <info>  [1472952652.4914] manager: NetworkManager state is now ASLEEP
Sep 03 21:30:52 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:52 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:52 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:52 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:52 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:52 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:52 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:52 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:52 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:52 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:56 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:56 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:56 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:56 osskil systemd-logind[643]: Delay lock is active (UID 1000/matt, PID 1168/gnome-shell) but inhibitor timeout is reached.
Sep 03 21:30:56 osskil systemd[1]: Reached target Sleep.
Sep 03 21:30:56 osskil systemd[1]: Starting Hybrid Suspend+Hibernate...
Sep 03 21:30:56 osskil kernel: PM: Hibernation mode set to 'suspend'
Sep 03 21:30:56 osskil systemd[1]: Stopping Atop advanced performance monitor...
Sep 03 21:30:56 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:56 osskil org .gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:56 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:56 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:56 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:56 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:57 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:57 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:57 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:57 osskil systemd[1]: Stopped Atop advanced performance monitor.
Sep 03 21:30:57 osskil systemd-sleep[15959]: Suspending system...
Sep 03 21:30:57 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:57 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:57 osskil systemd-logind[643]: Lid opened.
Sep 03 21:30:57 osskil systemd-logind[643]: Lid closed.
Sep 03 21:30:57 osskil org.gnome .Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:30:57 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:41 osskil kernel: PM: Syncing filesystems ... done.
Sep 03 21:31:41 osskil kernel: Freezing user space processes . .. (elapsed 0.002 seconds) done.
Sep 03 21:31:41 osskil kernel: Double checking all user space processes after OOM killer disable... (elapsed 0.000 seconds)
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0x00000000-0x00000fff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0x00058000-0x00058fff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0x0008c000-0x000fffff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0xd11cf000-0xd13d0fff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0xd2715000-0xd2715fff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0xd2725000-0xd2726fff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0xd2736000-0xd2736fff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0xdb93a000-0xdcefefff]
Sep 03 21:31:41 osskil kernel: PM: Marking nosave pages: [mem 0xdcf00000-0xffffffff]
Sep 03 21:31:41 osskil kernel: PM: Basic memory bitmaps created
Sep 03 21:31:41 osskil kernel: PM: Preallocating image memory... done (allocated 777105 pages)
Sep 03 21:31:41 osskil kernel: PM: Allocated 3108420 kbytes in 0.26 seconds (11955.46 MB/s)
Sep 03 21:31:41 osskil kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Sep 03 21:31:41 osskil kernel: Suspending console(s) (use no_console_suspend to debug)
Sep 03 21:31:41 osskil kernel: PM: freeze of devices complete after 486.510 msecs
Sep 03 21:31:41 osskil kernel: PM: late freeze of devices complete after 21.607 msecs
Sep 03 21:31:41 osskil kernel: PM: noirq freeze of devices complete after 0.732 msecs
Sep 03 21:31:41 osskil kernel: Disabling non-boot CPUs ...
Sep 03 21:31:41 osskil kernel: smpboot: CPU 1 is now offline
Sep 03 21:31:41 osskil kernel: smpboot: CPU 2 is now offline
Sep 03 21:31:41 osskil kernel: smpboot: CPU 3 is now offline
Sep 03 21:31:41 osskil kernel: PM: Creating hibernation image:
Sep 03 21:31:41 osskil kernel: PM: Need to copy 775926 pages
Sep 03 21:31:41 osskil kernel: PM: Normal pages needed: 775926 + 1024, available pages: 1295664
Sep 03 21:31:41 osskil kernel: PM: Hibernation image created (775926 pages copied)
Sep 03 21:31:41 osskil kernel: Enabling non-boot CPUs ...
Sep 03 21:31:41 osskil kernel: x86: Booting SMP configuration:
Sep 03 21:31:41 osskil kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Sep 03 21:31:41 osskil kernel:  cache: parent cpu1 should not be sleeping
Sep 03 21:31:41 osskil kernel: CPU1 is up
Sep 03 21:31:41 osskil kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2
Sep 03 21:31:41 osskil kernel:  cache: parent cpu2 should not be sleeping
Sep 03 21:31:41 osskil kernel: CPU2 is up
Sep 03 21:31:41 osskil kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
Sep 03 21:31:41 osskil kernel:  cache: parent cpu3 should not be sleeping
Sep 03 21:31:41 osskil kernel: CPU3 is up
Sep 03 21:31:41 osskil kernel: PM: noirq thaw of devices complete after 0.584 msecs
Sep 03 21:31:41 osskil kernel: PM: early thaw of devices complete after 27.102 msecs
Sep 03 21:31:41 osskil kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
Sep 03 21:31:41 osskil kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:31:41 osskil kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata1 .00: supports DRM functions and may not be fully accessible
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:31:41 osskil kernel: ata2.00: configured for UDMA/133
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:31:41 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:31:41 osskil kernel: ata1.00: configured for UDMA/133
Sep 03 21:31:41 osskil kernel: PM: thaw of devices complete after 482.825 msecs
Sep 03 21:31:41 osskil kernel: PM: writing image.
Sep 03 21:31:41 osskil kernel: PM: Using 3 thread(s) for compression.
                               PM: Compressing and saving image data (777442 pages)...
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:   0%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  10%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  20%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  30%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  40%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  50%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  60%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  70%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  80%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress:  90%
Sep 03 21:31:41 osskil kernel: PM: Image saving progress: 100%
Sep 03 21:31:41 osskil kernel: PM: Image saving done.
Sep 03 21:31:41 osskil kernel: PM: Wrote 3109768 kbytes in 35.53 seconds (87.52 MB/s)
Sep 03 21:31:41 osskil kernel: PM: S|
Sep 03 21:31:41 osskil kernel: Suspending console(s) (use no_console_suspend to debug)
Sep 03 21:31:41 osskil kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Sep 03 21:31:41 osskil kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 03 21:31:41 osskil kernel: sd 0:0:0:0: [sda] Stopping disk
Sep 03 21:31:41 osskil kernel: sd 1:0:0:0: [sdb] Stopping disk
Sep 03 21:31:41 osskil kernel: e1000e: EEE TX LPI TIMER: 00000011
Sep 03 21:31:41 osskil kernel: PM: suspend of devices complete after 1456.384 msecs
Sep 03 21:31:41 osskil kernel: PM: late suspend of devices complete after 20.520 msecs
Sep 03 21:31:41 osskil kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
Sep 03 21:31:41 osskil kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI
Sep 03 21:31:41 osskil kernel: xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
Sep 03 21:31:41 osskil kernel: PM: noirq suspend of devices complete after 13.681 msecs
Sep 03 21:31:41 osskil kernel: ACPI: Preparing to enter system sleep state S3
Sep 03 21:31:41 osskil kernel: ACPI : EC: EC stopped
Sep 03 21:31:41 osskil kernel: PM: Saving platform NVS memory
Sep 03 21:31:41 osskil kernel: Disabling non-boot CPUs ...
Sep 03 21:31:41 osskil kernel: smpboot: CPU 1 is now offline
Sep 03 21:31:41 osskil kernel: smpboot: CPU 2 is now offline
Sep 03 21:31:41 osskil kernel: smpboot: CPU 3 is now offline
Sep 03 21:31:41 osskil kernel: ACPI: Low-level resume complete
Sep 03 21:31:41 osskil kernel: ACPI : EC: EC started
Sep 03 21:31:41 osskil kernel: PM: Restoring platform NVS memory
Sep 03 21:31:41 osskil kernel: Enabling non-boot CPUs ...
Sep 03 21:31:41 osskil kernel: x86: Booting SMP configuration:
Sep 03 21:31:41 osskil kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Sep 03 21:31:41 osskil kernel:  cache: parent cpu1 should not be sleeping
Sep 03 21:31:41 osskil kernel: CPU1 is up
Sep 03 21:31:41 osskil kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2
Sep 03 21:31:41 osskil kernel:  cache: parent cpu2 should not be sleeping
Sep 03 21:31:41 osskil kernel: CPU2 is up
Sep 03 21:31:41 osskil kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
Sep 03 21:31:41 osskil kernel:  cache: parent cpu3 should not be sleeping
Sep 03 21:31:41 osskil kernel: CPU3 is up
Sep 03 21:31:41 osskil kernel: ACPI: Waking up from system sleep state S3
Sep 03 21:31:41 osskil kernel: acpi LNXPOWER:02: Turning OFF
Sep 03 21:31:41 osskil kernel: xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
Sep 03 21:31:41 osskil kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
Sep 03 21:31:41 osskil kernel: PM: noirq resume of devices complete after 18.320 msecs
Sep 03 21:31:41 osskil kernel: PM: early resume of devices complete after 6.158 msecs
Sep 03 21:31:41 osskil kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI
Sep 03 21:31:41 osskil kernel: usb usb2: root hub lost power or was reset
Sep 03 21:31:41 osskil kernel: usb usb3: root hub lost power or was reset
Sep 03 21:31:41 osskil kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
Sep 03 21:31:41 osskil kernel: sd 0:0:0:0: [sda] Starting disk
Sep 03 21:31:41 osskil kernel: sd 1:0:0:0: [sdb] Starting disk
Sep 03 21:31:41 osskil kernel: usb 1-1: reset high-speed USB device number 2 using ehci-pci
Sep 03 21:31:41 osskil kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:31:41 osskil kernel: ata2.00: configured for UDMA/133
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:31:41 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:31:41 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:31:41 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:31:41 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:31:41 osskil kernel: ata1.00: configured for UDMA/133
Sep 03 21:31:41 osskil kernel: psmouse serio1: synaptics: queried max coordinates: x [..5112], y [..3834]
Sep 03 21:31:41 osskil kernel: psmouse serio1: synaptics: queried min coordinates: x [1024..], y [1024..]
Sep 03 21:31:41 osskil kernel: psmouse serio1: synaptics: quirked min/max coordinates: x [1024..5112], y [2024..4832]
Sep 03 21:31:41 osskil kernel: usb 2-6: reset full-speed USB device number 2 using xhci_hcd
Sep 03 21:31:41 osskil kernel: usb 2-8: reset high-speed USB device number 4 using xhci_hcd
Sep 03 21:31:41 osskil kernel: usb 2-7: reset full-speed USB device number 3 using xhci_hcd
Sep 03 21:31:41 osskil kernel: PM: resume of devices complete after 1223.692 msecs
Sep 03 21:31:41 osskil kernel: usb 2-7:1.0: rebind failed: -517
Sep 03 21:31:41 osskil kernel: usb 2-7:1.1: rebind failed: -517
Sep 03 21:31:41 osskil kernel: Bluetooth: hci0: read Intel version: 370710018002030d00
Sep 03 21:31:41 osskil kernel: ------------[ cut here ]------------
Sep 03 21:31:41 osskil kernel: WARNING: CPU: 1 PID: 364 at drivers/base/firmware_class.c:1124 _request_firmware+0x465/0xaf0
Sep 03 21:31:41 osskil kernel: Modules linked in: fuse overlay ctr ccm uvcvideo videobuf2_vmalloc btusb videobuf2_memops videobuf2_v4l2 btrtl btbcm videobuf2_core btintel bluetooth videodev media snd_hda_codec_hdmi joydev mousedev arc4 nls_iso8859_1 nls_cp437 vfat fat snd_hda_codec_realtek snd_hda_codec_generic iTCO_wdt mei_wdt iTCO_vendor_support intel_rapl x86_pkg_temp_thermal iwlmvm intel_powerclamp coretemp mac80211 kvm irqbypass evdev intel_cstate intel_rapl_perf iwlwifi input_leds mac_hid psmouse pcspkr serio_raw cfg80211 rtsx_pci_ms memstick thermal wmi i915 thinkpad_acpi drm_kms_helper snd_hda_intel nvram battery led_class snd_hda_codec ac fjes rfkill snd_hda_core drm snd_hwdep e1000e snd_pcm intel_gtt syscopyarea sysfillrect sysimgblt snd_timer fb_sys_fops video mei_me button i2c_algo_bit snd ptp mei pps_core
Sep 03 21:31:41 osskil kernel:  i2c_i801 soundcore lpc_ich shpchp tpm_tis tpm sch_fq_codel vboxnetflt(O) vboxnetadp(O) pci_stub vboxpci(O) vboxdrv(O) acpi_call(O) ip_tables x_tables algif_skcipher af_alg dm_crypt sd_mod rtsx_pci_sdmmc mmc_core atkbd libps2 crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd ahci libahci libata xhci_pci ehci_pci xhci_hcd ehci_hcd scsi_mod rtsx_pci usbcore usb_common i8042 serio ext4 crc16 jbd2 mbcache dm_mod jitterentropy_rng sha256_ssse3 sha256_generic hmac drbg ansi_cprng
Sep 03 21:31:41 osskil kernel: CPU: 1 PID: 364 Comm: kworker/u17:0 Tainted: G        W  O    4.7.2-1-ARCH #1
Sep 03 21:31:41 osskil kernel: Hardware name: LENOVO 20AQCTO1WW/20AQCTO1WW, BIOS GJET89WW (2.39 ) 04/12/2016
Sep 03 21:31:41 osskil kernel: Workqueue: hci0 hci_power_on [bluetooth]
Sep 03 21:31:41 osskil kernel:  0000000000000286 00000000aa8980fa ffff880212dc7bb0 ffffffff812eb132
Sep 03 21:31:41 osskil kernel:  0000000000000000 0000000000000000 ffff880212dc7bf0 ffffffff8107a3ab
Sep 03 21:31:41 osskil kernel:  000004648108ef08 ffff880212dc7d10 ffff880212dc7cf8 ffff880023a6c360
Sep 03 21:31:41 osskil kernel: Call Trace:
Sep 03 21:31:41 osskil kernel:  [<ffffffff812eb132>] dump_stack+0x63/0x81
Sep 03 21:31:41 osskil kernel:  [<ffffffff8107a3ab>] __warn+0xcb/0xf0
Sep 03 21:31:41 osskil kernel:  [<ffffffff8107a4dd>] warn_slowpath_null+0x1d/0x20
Sep 03 21:31:41 osskil kernel:  [<ffffffff8143a5b5>] _request_firmware+0x465/0xaf0
Sep 03 21:31:41 osskil kernel:  [<ffffffff8143ac71>] request_firmware+0x31/0x50
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0a3fe24>] btusb_setup_intel+0x164/0x660 [btusb]
Sep 03 21:31:41 osskil kernel:  [<ffffffff8142f158>] ? rpm_idle+0x58/0x2b0
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0149460>] ? usb_autopm_put_interface+0x30/0x40 [usbcore]
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0acd2a1>] hci_dev_do_open+0x411/0x5a0 [bluetooth]
Sep 03 21:31:41 osskil kernel:  [<ffffffff8102c76f>] ? __switch_to+0x2bf/0x4b0
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0ad0f0a>] hci_power_on+0x5a/0x240 [bluetooth]
Sep 03 21:31:41 osskil kernel:  [<ffffffff815da5e5>] ? __schedule+0x2f5/0x7a0
Sep 03 21:31:41 osskil kernel:  [<ffffffff81093615>] process_one_work+0x1e5/0x480
Sep 03 21:31:41 osskil kernel:  [<ffffffff810938f8>] worker_thread+0x48/0x4e0
Sep 03 21:31:41 osskil kernel:  [<ffffffff810938b0>] ? process_one_work+0x480/0x480
Sep 03 21:31:41 osskil kernel:  [<ffffffff81099598>] kthread+0xd8/0xf0
Sep 03 21:31:41 osskil kernel:  [<ffffffff815de9bf>] ret_from_fork+0x1f/0x40
Sep 03 21:31:41 osskil kernel:  [<ffffffff810994c0>] ? kthread_worker_fn+0x170/0x170
Sep 03 21:31:41 osskil kernel: ---[ end trace d8c10d30111f3549 ]---
Sep 03 21:31:41 osskil kernel: bluetooth hci0: firmware: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq will not be loaded
Sep 03 21:31:41 osskil kernel: Bluetooth: hci0 failed to open Intel firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq(-11)
Sep 03 21:31:41 osskil kernel: ------------[ cut here ]------------
Sep 03 21:31:41 osskil kernel: WARNING: CPU: 1 PID: 364 at drivers/base/firmware_class.c:1124 _request_firmware+0x465/0xaf0
Sep 03 21:31:41 osskil kernel: Modules linked in: fuse overlay ctr ccm uvcvideo videobuf2_vmalloc btusb videobuf2_memops videobuf2_v4l2 btrtl btbcm videobuf2_core btintel bluetooth videodev media snd_hda_codec_hdmi joydev mousedev arc4 nls_iso8859_1 nls_cp437 vfat fat snd_hda_codec_realtek snd_hda_codec_generic iTCO_wdt mei_wdt iTCO_vendor_support intel_rapl x86_pkg_temp_thermal iwlmvm intel_powerclamp coretemp mac80211 kvm irqbypass evdev intel_cstate intel_rapl_perf iwlwifi input_leds mac_hid psmouse pcspkr serio_raw cfg80211 rtsx_pci_ms memstick thermal wmi i915 thinkpad_acpi drm_kms_helper snd_hda_intel nvram battery led_class snd_hda_codec ac fjes rfkill snd_hda_core drm snd_hwdep e1000e snd_pcm intel_gtt syscopyarea sysfillrect sysimgblt snd_timer fb_sys_fops video mei_me button i2c_algo_bit snd ptp mei pps_core
Sep 03 21:31:41 osskil kernel:  i2c_i801 soundcore lpc_ich shpchp tpm_tis tpm sch_fq_codel vboxnetflt(O) vboxnetadp(O) pci_stub vboxpci(O) vboxdrv(O) acpi_call(O) ip_tables x_tables algif_skcipher af_alg dm_crypt sd_mod rtsx_pci_sdmmc mmc_core atkbd libps2 crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd ahci libahci libata xhci_pci ehci_pci xhci_hcd ehci_hcd scsi_mod rtsx_pci usbcore usb_common i8042 serio ext4 crc16 jbd2 mbcache dm_mod jitterentropy_rng sha256_ssse3 sha256_generic hmac drbg ansi_cprng
Sep 03 21:31:41 osskil kernel: CPU: 1 PID: 364 Comm: kworker/u17:0 Tainted: G        W  O    4.7.2-1-ARCH #1
Sep 03 21:31:41 osskil kernel: Hardware name: LENOVO 20AQCTO1WW/20AQCTO1WW, BIOS GJET89WW (2.39 ) 04/12/2016
Sep 03 21:31:41 osskil kernel: Workqueue: hci0 hci_power_on [bluetooth]
Sep 03 21:31:41 osskil kernel:  0000000000000286 00000000aa8980fa ffff880212dc7bb0 ffffffff812eb132
Sep 03 21:31:41 osskil kernel:  0000000000000000 0000000000000000 ffff880212dc7bf0 ffffffff8107a3ab
Sep 03 21:31:41 osskil kernel:  000004648108ef08 ffff880212dc7d10 ffff880212dc7cf8 ffff880023a6c360
Sep 03 21:31:41 osskil kernel: Call Trace:
Sep 03 21:31:41 osskil kernel:  [<ffffffff812eb132>] dump_stack+0x63/0x81
Sep 03 21:31:41 osskil kernel:  [<ffffffff8107a3ab>] __warn+0xcb/0xf0
Sep 03 21:31:41 osskil kernel:  [<ffffffff8107a4dd>] warn_slowpath_null+0x1d/0x20
Sep 03 21:31:41 osskil kernel:  [<ffffffff8143a5b5>] _request_firmware+0x465/0xaf0
Sep 03 21:31:41 osskil kernel:  [<ffffffff8143ac71>] request_firmware+0x31/0x50
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0a4011c>] btusb_setup_intel+0x45c/0x660 [btusb]
Sep 03 21:31:41 osskil kernel:  [<ffffffff8142f158>] ? rpm_idle+0x58/0x2b0
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0149460>] ? usb_autopm_put_interface+0x30/0x40 [usbcore]
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0acd2a1>] hci_dev_do_open+0x411/0x5a0 [bluetooth]
Sep 03 21:31:41 osskil kernel:  [<ffffffff8102c76f>] ? __switch_to+0x2bf/0x4b0
Sep 03 21:31:41 osskil kernel:  [<ffffffffa0ad0f0a>] hci_power_on+0x5a/0x240 [bluetooth]
Sep 03 21:31:41 osskil kernel:  [<ffffffff815da5e5>] ? __schedule+0x2f5/0x7a0
Sep 03 21:31:41 osskil kernel:  [<ffffffff81093615>] process_one_work+0x1e5/0x480
Sep 03 21:31:41 osskil kernel:  [<ffffffff810938f8>] worker_thread+0x48/0x4e0
Sep 03 21:31:41 osskil kernel:  [<ffffffff810938b0>] ? process_one_work+0x480/0x480
Sep 03 21:31:41 osskil kernel:  [<ffffffff81099598>] kthread+0xd8/0xf0
Sep 03 21:31:41 osskil kernel:  [<ffffffff815de9bf>] ret_from_fork+0x1f/0x40
Sep 03 21:31:41 osskil kernel:  [<ffffffff810994c0>] ? kthread_worker_fn+0x170/0x170
Sep 03 21:31:41 osskil kernel: ---[ end trace d8c10d30111f354a ]---
Sep 03 21:31:41 osskil kernel: bluetooth hci0: firmware: intel/ibt-hw-37.7.bseq will not be loaded
Sep 03 21:31:41 osskil kernel: Bluetooth: hci0 failed to open default Intel fw file: intel/ibt-hw-37.7.bseq
Sep 03 21:31:41 osskil kernel: PM: Basic memory bitmaps freed
Sep 03 21:31:41 osskil systemd[1]: Time has been changed
Sep 03 21:31:41 osskil rtkit-daemon[763]: The canary thread is apparently starving. Taking action.
Sep 03 21:31:41 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:41 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:41 osskil rtkit-daemon[763]: Demoting known real-time threads.
Sep 03 21:31:41 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:41 osskil rtkit-daemon[763]: Successfully demoted thread 1194 of process 1194 (/usr/bin/pulseaudio).
Sep 03 21:31:41 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:41 osskil rtkit-daemon[763]: Demoted 1 threads.
Sep 03 21:31:41 osskil kernel: Restarting tasks ... done.
Sep 03 21:31:41 osskil systemd[939]: Time has been changed
Sep 03 21:31:41 osskil systemd[688]: Time has been changed
Sep 03 21:31:41 osskil systemd[1]: Starting Load/Save RF Kill Switch Status...
Sep 03 21:31:41 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:41 osskil systemd[1]: bluetooth.target: Unit not needed anymore. Stopping.
Sep 03 21:31:41 osskil systemd[1]: Stopped target Bluetooth.
Sep 03 21:31:41 osskil systemd[1]: Reached target Bluetooth.
Sep 03 21:31:41 osskil systemd-sleep[15959]: System resumed.
Sep 03 21:31:41 osskil systemd[1]: Started Load/Save RF Kill Switch Status.
Sep 03 21:31:41 osskil systemd[1]: Started Atop advanced performance monitor.
Sep 03 21:31:41 osskil systemd[1]: Started Hybrid Suspend+Hibernate.
Sep 03 21:31:41 osskil systemd[1]: sleep.target: Unit not needed anymore. Stopping.
Sep 03 21:31:41 osskil systemd[1]: Stopped target Sleep.
Sep 03 21:31:41 osskil systemd[1]: Reached target Hybrid Suspend+Hibernate.
Sep 03 21:31:41 osskil systemd-logind[643]: Operation 'sleep' finished.
Sep 03 21:31:41 osskil systemd[1]: hybrid-sleep.target: Unit is bound to inactive unit systemd-hybrid-sleep.service. Stopping, too.
Sep 03 21:31:41 osskil systemd[1]: Stopped target Hybrid Suspend+Hibernate.
Sep 03 21:31:41 osskil NetworkManager[649]: <info>  [1472952701.7157] manager: wake requested (sleeping: yes  enabled: yes)
Sep 03 21:31:41 osskil NetworkManager[649]: <info>  [1472952701.7158] manager: waking up...
Sep 03 21:31:41 osskil NetworkManager[649]: <info>  [1472952701.7158] device (enp0s25): state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37]
Sep 03 21:31:41 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to set power save mode for output eDP37: Permission denied
Sep 03 21:31:41 osskil kernel: Process accounting resumed
Sep 03 21:31:41 osskil kernel: e1000e: enp0s25 NIC Link is Down
Sep 03 21:31:41 osskil NetworkManager[649]: <info>  [1472952701.8154] device (enp0s25): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 03 21:31:41 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Sep 03 21:31:42 osskil NetworkManager[649]: <info>  [1472952702.0193] device (wlp3s0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 03 21:31:42 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Sep 03 21:31:42 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:31:42 osskil NetworkManager[649]: <info>  [1472952702.2710] device (wlp3s0): set-hw-addr: set MAC address to 4E:93:C0:DC:6A:F8 (scanning)
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:31:42 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:31:42 osskil NetworkManager[649]: <info>  [1472952702.5254] manager: NetworkManager state is now DISCONNECTED
Sep 03 21:31:42 osskil wpa_supplicant[767]: Could not read interface p2p-dev-wlp3s0 flags: No such device
Sep 03 21:31:42 osskil NetworkManager[649]: <info>  [1472952702.5787] sup-iface[0x2369220,wlp3s0]: supports 5 scan SSIDs
Sep 03 21:31:42 osskil NetworkManager[649]: <info>  [1472952702.5798] device (wlp3s0): supplicant interface state: starting -> ready
Sep 03 21:31:42 osskil NetworkManager[649]: <info>  [1472952702.5799] device (wlp3s0): state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Sep 03 21:31:42 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:31:43 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:43 osskil systemd-logind[643]: Hibernating and suspending...
Sep 03 21:31:43 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:43 osskil NetworkManager[649]: <info>  [1472952703.8281] manager: sleep requested (sleeping: no  enabled: yes)
Sep 03 21:31:43 osskil NetworkManager[649]: <info>  [1472952703.8282] manager: sleeping...
Sep 03 21:31:43 osskil NetworkManager[649]: <info>  [1472952703.8283] device (wlp3s0): state change: disconnected -> unmanaged (reason 'sleeping') [30 10 37]
Sep 03 21:31:43 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to set power save mode for output eDP37: Permission denied
Sep 03 21:31:43 osskil NetworkManager[649]: <info>  [1472952703.8321] device (wlp3s0): set-hw-addr: reset MAC address to 5C:51:4F:4E:17:95 (unmanage)
Sep 03 21:31:43 osskil NetworkManager[649]: <info>  [1472952703.8326] manager: NetworkManager state is now ASLEEP
Sep 03 21:31:43 osskil wpa_supplicant[767]: nl80211: deinit ifname=p2p-dev-wlp3s0 disabled_11b_rates=0
Sep 03 21:31:43 osskil wpa_supplicant[767]: nl80211: deinit ifname=wlp3s0 disabled_11b_rates=0
Sep 03 21:31:44 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:45 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:45 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:45 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:46 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:46 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:47 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:47 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:47 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:47 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:47 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:47 osskil org.gnome.Shell .desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:47 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:48 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:48 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:48 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:48 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:48 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:48 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:48 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:48 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:48 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:48 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:48 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:48 osskil systemd-logind[643]: Lid opened.
Sep 03 21:31:48 osskil systemd-logind[643]: Delay lock is active (UID 1000/matt, PID 1168/gnome-shell) but inhibitor timeout is reached.
Sep 03 21:31:48 osskil systemd[1]: Reached target Sleep.
Sep 03 21:31:48 osskil systemd[1]: Starting Hybrid Suspend+Hibernate...
Sep 03 21:31:48 osskil kernel: PM: Hibernation mode set to 'suspend'
Sep 03 21:31:48 osskil systemd[1]: Stopping Atop advanced performance monitor...
Sep 03 21:31:48 osskil systemd-logind[643]: Lid closed.
Sep 03 21:31:48 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:31:49 osskil systemd[1]: Stopped Atop advanced performance monitor.
Sep 03 21:31:49 osskil systemd-sleep[16015]: Suspending system...
Sep 03 21:31:49 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:30 osskil kernel: PM: Syncing filesystems ... done.
Sep 03 21:32:30 osskil kernel: Freezing user space processes ... (elapsed 0.003 seconds) done.
Sep 03 21:32:30 osskil kernel: Double checking all user space processes after OOM killer disable... (elapsed 0.000 seconds)
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0x00000000-0x00000fff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0x00058000-0x00058fff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0x0008c000-0x000fffff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0xd11cf000-0xd13d0fff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0xd2715000-0xd2715fff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0xd2725000-0xd2726fff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0xd2736000-0xd2736fff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0xdb93a000-0xdcefefff]
Sep 03 21:32:30 osskil kernel: PM: Marking nosave pages: [mem 0xdcf00000-0xffffffff]
Sep 03 21:32:30 osskil kernel: PM: Basic memory bitmaps created
Sep 03 21:32:30 osskil kernel: PM: Preallocating image memory... done (allocated 775360 pages)
Sep 03 21:32:30 osskil kernel: PM: Allocated 3101440 kbytes in 0.25 seconds (12405.76 MB/s)
Sep 03 21:32:30 osskil kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Sep 03 21:32:30 osskil kernel: Suspending console(s) (use no_console_suspend to debug)
Sep 03 21:32:30 osskil kernel: PM: freeze of devices complete after 505.392 msecs
Sep 03 21:32:30 osskil kernel: PM: late freeze of devices complete after 21.846 msecs
Sep 03 21:32:30 osskil kernel: PM: noirq freeze of devices complete after 3.032 msecs
Sep 03 21:32:30 osskil kernel: Disabling non-boot CPUs ...
Sep 03 21:32:30 osskil kernel: smpboot: CPU 1 is now offline
Sep 03 21:32:30 osskil kernel: smpboot: CPU 2 is now offline
Sep 03 21:32:30 osskil kernel: smpboot: CPU 3 is now offline
Sep 03 21:32:30 osskil kernel: PM: Creating hibernation image:
Sep 03 21:32:30 osskil kernel: PM: Need to copy 774040 pages
Sep 03 21:32:30 osskil kernel: PM: Normal pages needed: 774040 + 1024, available pages: 1297548
Sep 03 21:32:30 osskil kernel: PM: Hibernation image created (774040 pages copied)
Sep 03 21:32:30 osskil kernel: Enabling non-boot CPUs ...
Sep 03 21:32:30 osskil kernel: x86: Booting SMP configuration:
Sep 03 21:32:30 osskil kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Sep 03 21:32:30 osskil kernel:  cache: parent cpu1 should not be sleeping
Sep 03 21:32:30 osskil kernel: CPU1 is up
Sep 03 21:32:30 osskil kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2
Sep 03 21:32:30 osskil kernel:  cache: parent cpu2 should not be sleeping
Sep 03 21:32:30 osskil kernel: CPU2 is up
Sep 03 21:32:30 osskil kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
Sep 03 21:32:30 osskil kernel:  cache: parent cpu3 should not be sleeping
Sep 03 21:32:30 osskil kernel: CPU3 is up
Sep 03 21:32:30 osskil kernel: PM: noirq thaw of devices complete after 0.197 msecs
Sep 03 21:32:30 osskil kernel: PM: early thaw of devices complete after 20.898 msecs
Sep 03 21:32:30 osskil kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
Sep 03 21:32:30 osskil kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:32:30 osskil kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: configured for UDMA/133
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:32:30 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1 .00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:32:30 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:32:30 osskil kernel: ata1.00: configured for UDMA/133
Sep 03 21:32:30 osskil kernel: PM: thaw of devices complete after 473.826 msecs
Sep 03 21:32:30 osskil kernel: PM: writing image.
Sep 03 21:32:30 osskil kernel: PM: Using 3 thread(s) for compression.
                               PM: Compressing and saving image data (775552 pages)...
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:   0%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  10%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  20%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  30%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  40%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  50%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  60%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  70%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  80%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress:  90%
Sep 03 21:32:30 osskil kernel: PM: Image saving progress: 100%
Sep 03 21:32:30 osskil kernel: PM: Image saving done.
Sep 03 21:32:30 osskil kernel: PM: Wrote 3102208 kbytes in 32.74 seconds (94.75 MB/s)
Sep 03 21:32:30 osskil kernel: PM: S|
Sep 03 21:32:30 osskil kernel: Suspending console(s) (use no_console_suspend to debug)
Sep 03 21:32:30 osskil kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Sep 03 21:32:30 osskil kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 03 21:32:30 osskil kernel: sd 0:0:0:0: [sda] Stopping disk
Sep 03 21:32:30 osskil kernel: sd 1:0:0:0: [sdb] Stopping disk
Sep 03 21:32:30 osskil kernel: e1000e: EEE TX LPI TIMER: 00000011
Sep 03 21:32:30 osskil kernel: PM: suspend of devices complete after 1462.174 msecs
Sep 03 21:32:30 osskil kernel: PM: late suspend of devices complete after 21.373 msecs
Sep 03 21:32:30 osskil kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
Sep 03 21:32:30 osskil kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI
Sep 03 21:32:30 osskil kernel: xhci_hcd 0000:00:14 .0: System wakeup enabled by ACPI
Sep 03 21:32:30 osskil kernel: PM: noirq suspend of devices complete after 13.803 msecs
Sep 03 21:32:30 osskil kernel: ACPI: Preparing to enter system sleep state S3
Sep 03 21:32:30 osskil kernel: ACPI : EC: EC stopped
Sep 03 21:32:30 osskil kernel: PM: Saving platform NVS memory
Sep 03 21:32:30 osskil kernel: Disabling non-boot CPUs ...
Sep 03 21:32:30 osskil kernel: ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20160422/evregion-300)
Sep 03 21:32:30 osskil kernel: ACPI Error: Method parse/execution failed [\_SB.LID._LID] (Node ffff8802158a7d48), AE_BAD_PARAMETER (20160422/psparse-542)
Sep 03 21:32:30 osskil kernel: smpboot: CPU 1 is now offline
Sep 03 21:32:30 osskil kernel: smpboot: CPU 2 is now offline
Sep 03 21:32:30 osskil kernel: smpboot: CPU 3 is now offline
Sep 03 21:32:30 osskil kernel: ACPI: Low-level resume complete
Sep 03 21:32:30 osskil kernel: ACPI : EC: EC started
Sep 03 21:32:30 osskil kernel: PM: Restoring platform NVS memory
Sep 03 21:32:30 osskil kernel: Enabling non-boot CPUs ...
Sep 03 21:32:30 osskil kernel: x86: Booting SMP configuration:
Sep 03 21:32:30 osskil kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Sep 03 21:32:30 osskil kernel:  cache: parent cpu1 should not be sleeping
Sep 03 21:32:30 osskil kernel: CPU1 is up
Sep 03 21:32:30 osskil kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2
Sep 03 21:32:30 osskil kernel:  cache: parent cpu2 should not be sleeping
Sep 03 21:32:30 osskil kernel: CPU2 is up
Sep 03 21:32:30 osskil kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
Sep 03 21:32:30 osskil kernel:  cache: parent cpu3 should not be sleeping
Sep 03 21:32:30 osskil kernel: CPU3 is up
Sep 03 21:32:30 osskil kernel: ACPI: Waking up from system sleep state S3
Sep 03 21:32:30 osskil kernel: acpi LNXPOWER:02: Turning OFF
Sep 03 21:32:30 osskil kernel: xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
Sep 03 21:32:30 osskil kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
Sep 03 21:32:30 osskil kernel: PM: noirq resume of devices complete after 18.877 msecs
Sep 03 21:32:30 osskil kernel: PM: early resume of devices complete after 6.154 msecs
Sep 03 21:32:30 osskil kernel: usb usb2: root hub lost power or was reset
Sep 03 21:32:30 osskil kernel: usb usb3: root hub lost power or was reset
Sep 03 21:32:30 osskil kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI
Sep 03 21:32:30 osskil kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
Sep 03 21:32:30 osskil kernel: sd 0:0:0:0: [sda] Starting disk
Sep 03 21:32:30 osskil kernel: sd 1:0:0:0: [sdb] Starting disk
Sep 03 21:32:30 osskil kernel: usb 1-1: reset high-speed USB device number 2 using ehci-pci
Sep 03 21:32:30 osskil kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:32:30 osskil kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata2 .00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata2.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata2.00: configured for UDMA/133
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:32:30 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Sep 03 21:32:30 osskil kernel: ata1.00: ACPI cmd ef/10:09:00:00:00:a0 (SET FEATURES) succeeded
Sep 03 21:32:30 osskil kernel: ata1.00: supports DRM functions and may not be fully accessible
Sep 03 21:32:30 osskil kernel: ata1.00: NCQ Send/Recv Log not supported
Sep 03 21:32:30 osskil kernel: ata1.00: configured for UDMA/133
Sep 03 21:32:30 osskil kernel: psmouse serio1: synaptics: queried max coordinates: x [..5112], y [..3834]
Sep 03 21:32:30 osskil kernel: psmouse serio1: synaptics: queried min coordinates: x [1024..], y [1024..]
Sep 03 21:32:30 osskil kernel: psmouse serio1: synaptics: quirked min/max coordinates: x [1024..5112], y [2024..4832]
Sep 03 21:32:30 osskil kernel: usb 2-6: reset full-speed USB device number 2 using xhci_hcd
Sep 03 21:32:30 osskil kernel: usb 2-7: reset full-speed USB device number 3 using xhci_hcd
Sep 03 21:32:30 osskil kernel: usb 2-8: reset high-speed USB device number 4 using xhci_hcd
Sep 03 21:32:30 osskil kernel: PM: resume of devices complete after 1282.850 msecs
Sep 03 21:32:30 osskil kernel: usb 2-7:1.0: rebind failed: -517
Sep 03 21:32:30 osskil kernel: usb 2-7:1.1: rebind failed: -517
Sep 03 21:32:30 osskil kernel: Bluetooth: hci0: read Intel version: 370710018002030d00
Sep 03 21:32:30 osskil kernel: ------------[ cut here ]------------
Sep 03 21:32:30 osskil kernel: WARNING: CPU: 0 PID: 364 at drivers/base/firmware_class.c:1124 _request_firmware+0x465/0xaf0
Sep 03 21:32:30 osskil kernel: Modules linked in: fuse overlay ctr ccm uvcvideo videobuf2_vmalloc btusb videobuf2_memops videobuf2_v4l2 btrtl btbcm videobuf2_core btintel bluetooth videodev media snd_hda_codec_hdmi joydev mousedev arc4 nls_iso8859_1 nls_cp437 vfat fat snd_hda_codec_realtek snd_hda_codec_generic iTCO_wdt mei_wdt iTCO_vendor_support intel_rapl x86_pkg_temp_thermal iwlmvm intel_powerclamp coretemp mac80211 kvm irqbypass evdev intel_cstate intel_rapl_perf iwlwifi input_leds mac_hid psmouse pcspkr serio_raw cfg80211 rtsx_pci_ms memstick thermal wmi i915 thinkpad_acpi drm_kms_helper snd_hda_intel nvram battery led_class snd_hda_codec ac fjes rfkill snd_hda_core drm snd_hwdep e1000e snd_pcm intel_gtt syscopyarea sysfillrect sysimgblt snd_timer fb_sys_fops video mei_me button i2c_algo_bit snd ptp mei pps_core
Sep 03 21:32:30 osskil kernel:  i2c_i801 soundcore lpc_ich shpchp tpm_tis tpm sch_fq_codel vboxnetflt(O) vboxnetadp(O) pci_stub vboxpci(O) vboxdrv(O) acpi_call(O) ip_tables x_tables algif_skcipher af_alg dm_crypt sd_mod rtsx_pci_sdmmc mmc_core atkbd libps2 crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd ahci libahci libata xhci_pci ehci_pci xhci_hcd ehci_hcd scsi_mod rtsx_pci usbcore usb_common i8042 serio ext4 crc16 jbd2 mbcache dm_mod jitterentropy_rng sha256_ssse3 sha256_generic hmac drbg ansi_cprng
Sep 03 21:32:30 osskil kernel: CPU: 0 PID: 364 Comm: kworker/u17:0 Tainted: G        W  O    4.7.2-1-ARCH #1
Sep 03 21:32:30 osskil kernel: Hardware name: LENOVO 20AQCTO1WW/20AQCTO1WW, BIOS GJET89WW (2.39 ) 04/12/2016
Sep 03 21:32:30 osskil kernel: Workqueue: hci0 hci_power_on [bluetooth]
Sep 03 21:32:30 osskil kernel:  0000000000000286 00000000aa8980fa ffff880212dc7bb0 ffffffff812eb132
Sep 03 21:32:30 osskil kernel:  0000000000000000 0000000000000000 ffff880212dc7bf0 ffffffff8107a3ab
Sep 03 21:32:30 osskil kernel:  000004648108ef08 ffff880212dc7d10 ffff880212dc7cf8 ffff88015fcf0720
Sep 03 21:32:30 osskil kernel: Call Trace:
Sep 03 21:32:30 osskil kernel:  [<ffffffff812eb132>] dump_stack+0x63/0x81
Sep 03 21:32:30 osskil kernel:  [<ffffffff8107a3ab>] __warn+0xcb/0xf0
Sep 03 21:32:30 osskil kernel:  [<ffffffff8107a4dd>] warn_slowpath_null+0x1d/0x20
Sep 03 21:32:30 osskil kernel:  [<ffffffff8143a5b5>] _request_firmware+0x465/0xaf0
Sep 03 21:32:30 osskil kernel:  [<ffffffff8143ac71>] request_firmware+0x31/0x50
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0a3fe24>] btusb_setup_intel+0x164/0x660 [btusb]
Sep 03 21:32:30 osskil kernel:  [<ffffffff8142f158>] ? rpm_idle+0x58/0x2b0
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0149460>] ? usb_autopm_put_interface+0x30/0x40 [usbcore]
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0acd2a1>] hci_dev_do_open+0x411/0x5a0 [bluetooth]
Sep 03 21:32:30 osskil kernel:  [<ffffffff8102c76f>] ? __switch_to+0x2bf/0x4b0
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0ad0f0a>] hci_power_on+0x5a/0x240 [bluetooth]
Sep 03 21:32:30 osskil kernel:  [<ffffffff815da5e5>] ? __schedule+0x2f5/0x7a0
Sep 03 21:32:30 osskil kernel:  [<ffffffff81093615>] process_one_work+0x1e5/0x480
Sep 03 21:32:30 osskil kernel:  [<ffffffff810938f8>] worker_thread+0x48/0x4e0
Sep 03 21:32:30 osskil kernel:  [<ffffffff810938b0>] ? process_one_work+0x480/0x480
Sep 03 21:32:30 osskil kernel:  [<ffffffff81099598>] kthread+0xd8/0xf0
Sep 03 21:32:30 osskil kernel:  [<ffffffff815de9bf>] ret_from_fork+0x1f/0x40
Sep 03 21:32:30 osskil kernel:  [<ffffffff810994c0>] ? kthread_worker_fn+0x170/0x170
Sep 03 21:32:30 osskil kernel: ---[ end trace d8c10d30111f354b ]---
Sep 03 21:32:30 osskil kernel: bluetooth hci0: firmware: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq will not be loaded
Sep 03 21:32:30 osskil kernel: Bluetooth: hci0 failed to open Intel firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq(-11)
Sep 03 21:32:30 osskil kernel: ------------[ cut here ]------------
Sep 03 21:32:30 osskil kernel: WARNING: CPU: 0 PID: 364 at drivers/base/firmware_class.c:1124 _request_firmware+0x465/0xaf0
Sep 03 21:32:30 osskil kernel: Modules linked in: fuse overlay ctr ccm uvcvideo videobuf2_vmalloc btusb videobuf2_memops videobuf2_v4l2 btrtl btbcm videobuf2_core btintel bluetooth videodev media snd_hda_codec_hdmi joydev mousedev arc4 nls_iso8859_1 nls_cp437 vfat fat snd_hda_codec_realtek snd_hda_codec_generic iTCO_wdt mei_wdt iTCO_vendor_support intel_rapl x86_pkg_temp_thermal iwlmvm intel_powerclamp coretemp mac80211 kvm irqbypass evdev intel_cstate intel_rapl_perf iwlwifi input_leds mac_hid psmouse pcspkr serio_raw cfg80211 rtsx_pci_ms memstick thermal wmi i915 thinkpad_acpi drm_kms_helper snd_hda_intel nvram battery led_class snd_hda_codec ac fjes rfkill snd_hda_core drm snd_hwdep e1000e snd_pcm intel_gtt syscopyarea sysfillrect sysimgblt snd_timer fb_sys_fops video mei_me button i2c_algo_bit snd ptp mei pps_core
Sep 03 21:32:30 osskil kernel:  i2c_i801 soundcore lpc_ich shpchp tpm_tis tpm sch_fq_codel vboxnetflt(O) vboxnetadp(O) pci_stub vboxpci(O) vboxdrv(O) acpi_call(O) ip_tables x_tables algif_skcipher af_alg dm_crypt sd_mod rtsx_pci_sdmmc mmc_core atkbd libps2 crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd ahci libahci libata xhci_pci ehci_pci xhci_hcd ehci_hcd scsi_mod rtsx_pci usbcore usb_common i8042 serio ext4 crc16 jbd2 mbcache dm_mod jitterentropy_rng sha256_ssse3 sha256_generic hmac drbg ansi_cprng
Sep 03 21:32:30 osskil kernel: CPU: 0 PID: 364 Comm: kworker/u17:0 Tainted: G        W  O    4.7.2-1-ARCH #1
Sep 03 21:32:30 osskil kernel: Hardware name: LENOVO 20AQCTO1WW/20AQCTO1WW, BIOS GJET89WW (2.39 ) 04/12/2016
Sep 03 21:32:30 osskil kernel: Workqueue: hci0 hci_power_on [bluetooth]
Sep 03 21:32:30 osskil kernel:  0000000000000286 00000000aa8980fa ffff880212dc7bb0 ffffffff812eb132
Sep 03 21:32:30 osskil kernel:  0000000000000000 0000000000000000 ffff880212dc7bf0 ffffffff8107a3ab
Sep 03 21:32:30 osskil kernel:  000004648108ef08 ffff880212dc7d10 ffff880212dc7cf8 ffff88015fcf0720
Sep 03 21:32:30 osskil kernel: Call Trace:
Sep 03 21:32:30 osskil kernel:  [<ffffffff812eb132>] dump_stack+0x63/0x81
Sep 03 21:32:30 osskil kernel:  [<ffffffff8107a3ab>] __warn+0xcb/0xf0
Sep 03 21:32:30 osskil kernel:  [<ffffffff8107a4dd>] warn_slowpath_null+0x1d/0x20
Sep 03 21:32:30 osskil kernel:  [<ffffffff8143a5b5>] _request_firmware+0x465/0xaf0
Sep 03 21:32:30 osskil kernel:  [<ffffffff8143ac71>] request_firmware+0x31/0x50
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0a4011c>] btusb_setup_intel+0x45c/0x660 [btusb]
Sep 03 21:32:30 osskil kernel:  [<ffffffff8142f158>] ? rpm_idle+0x58/0x2b0
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0149460>] ? usb_autopm_put_interface+0x30/0x40 [usbcore]
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0acd2a1>] hci_dev_do_open+0x411/0x5a0 [bluetooth]
Sep 03 21:32:30 osskil kernel:  [<ffffffff8102c76f>] ? __switch_to+0x2bf/0x4b0
Sep 03 21:32:30 osskil kernel:  [<ffffffffa0ad0f0a>] hci_power_on+0x5a/0x240 [bluetooth]
Sep 03 21:32:30 osskil kernel:  [<ffffffff815da5e5>] ? __schedule+0x2f5/0x7a0
Sep 03 21:32:30 osskil kernel:  [<ffffffff81093615>] process_one_work+0x1e5/0x480
Sep 03 21:32:30 osskil kernel:  [<ffffffff810938f8>] worker_thread+0x48/0x4e0
Sep 03 21:32:30 osskil kernel:  [<ffffffff810938b0>] ? process_one_work+0x480/0x480
Sep 03 21:32:30 osskil kernel:  [<ffffffff81099598>] kthread+0xd8/0xf0
Sep 03 21:32:30 osskil kernel:  [<ffffffff815de9bf>] ret_from_fork+0x1f/0x40
Sep 03 21:32:30 osskil kernel:  [<ffffffff810994c0>] ? kthread_worker_fn+0x170/0x170
Sep 03 21:32:30 osskil kernel: ---[ end trace d8c10d30111f354c ]---
Sep 03 21:32:30 osskil kernel: bluetooth hci0: firmware: intel/ibt-hw-37.7.bseq will not be loaded
Sep 03 21:32:30 osskil kernel: Bluetooth: hci0 failed to open default Intel fw file: intel/ibt-hw-37.7.bseq
Sep 03 21:32:30 osskil kernel: PM: Basic memory bitmaps freed
Sep 03 21:32:30 osskil kernel: Restarting tasks ... done.
Sep 03 21:32:30 osskil systemd[1]: Time has been changed
Sep 03 21:32:30 osskil rtkit-daemon[763]: The canary thread is apparently starving. Taking action.
Sep 03 21:32:30 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:30 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:30 osskil rtkit-daemon[763]: Demoting known real-time threads.
Sep 03 21:32:30 osskil systemd[688]: Time has been changed
Sep 03 21:32:30 osskil rtkit-daemon[763]: Successfully demoted thread 1194 of process 1194 (/usr/bin/pulseaudio).
Sep 03 21:32:30 osskil systemd[939]: Time has been changed
Sep 03 21:32:30 osskil rtkit-daemon[763]: Demoted 1 threads.
Sep 03 21:32:30 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:30 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:30 osskil systemd[1]: Starting Load/Save RF Kill Switch Status.. .
Sep 03 21:32:30 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:30 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:30 osskil systemd-sleep[16015]: System resumed.
Sep 03 21:32:30 osskil systemd[1]: bluetooth.target: Unit not needed anymore. Stopping.
Sep 03 21:32:30 osskil systemd[1]: Stopped target Bluetooth.
Sep 03 21:32:30 osskil systemd[1]: Started Atop advanced performance monitor.
Sep 03 21:32:30 osskil systemd[1]: Reached target Bluetooth.
Sep 03 21:32:30 osskil systemd[1]: Started Hybrid Suspend+Hibernate.
Sep 03 21:32:30 osskil systemd[1]: sleep.target: Unit not needed anymore. Stopping.
Sep 03 21:32:30 osskil systemd[1]: Stopped target Sleep.
Sep 03 21:32:30 osskil systemd[1]: Reached target Hybrid Suspend+Hibernate.
Sep 03 21:32:30 osskil systemd[1]: hybrid-sleep.target: Unit is bound to inactive unit systemd-hybrid-sleep.service . Stopping, too.
Sep 03 21:32:30 osskil systemd[1]: Stopped target Hybrid Suspend+Hibernate.
Sep 03 21:32:30 osskil systemd-logind[643]: Operation 'sleep' finished.
Sep 03 21:32:30 osskil systemd-logind[643]: Hibernating and suspending...
Sep 03 21:32:30 osskil NetworkManager[649]: <info>  [1472952750.7667] manager: wake requested (sleeping: yes  enabled: yes)
Sep 03 21:32:30 osskil NetworkManager[649]: <info>  [1472952750.7667] manager: waking up...
Sep 03 21:32:30 osskil NetworkManager[649]: <info>  [1472952750.7668] device (enp0s25): state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37]
Sep 03 21:32:30 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to set power save mode for output eDP37: Permission denied
Sep 03 21:32:30 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to set power save mode for output eDP37: Permission denied
Sep 03 21:32:30 osskil systemd[1]: Started Load/Save RF Kill Switch Status.
Sep 03 21:32:30 osskil kernel: Process accounting resumed
Sep 03 21:32:30 osskil kernel: e1000e: enp0s25 NIC Link is Down
Sep 03 21:32:30 osskil NetworkManager[649]: <info>  [1472952750.8720] device (enp0s25): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 03 21:32:30 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Sep 03 21:32:30 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:31 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:31 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.0770] device (wlp3s0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 03 21:32:31 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Sep 03 21:32:31 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:31 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:31 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.3323] device (wlp3s0): set-hw-addr: set MAC address to 4E:93:C0:DC:6A:F8 (scanning)
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
Sep 03 21:32:31 osskil kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.5729] manager: NetworkManager state is now DISCONNECTED
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.5754] manager: sleep requested (sleeping: no  enabled: yes)
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.5758] manager: sleeping...
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.5761] device (wlp3s0): state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37]
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.5857] device (wlp3s0): set-hw-addr: reset MAC address to 5C:51:4F:4E:17:95 (unmanage)
Sep 03 21:32:31 osskil NetworkManager[649]: <info>  [1472952751.5869] manager: NetworkManager state is now ASLEEP
Sep 03 21:32:32 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:32 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:32 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:33 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:33 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:33 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:33 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:33 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:33 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:35 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:35 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:35 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:35 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:35 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:35 osskil systemd-logind[643]: Delay lock is active (UID 1000/matt, PID 1168/gnome-shell) but inhibitor timeout is reached.
Sep 03 21:32:35 osskil systemd[1]: Reached target Sleep.
Sep 03 21:32:35 osskil systemd[1]: Starting Hybrid Suspend+Hibernate...
Sep 03 21:32:35 osskil kernel: PM: Hibernation mode set to 'suspend'
Sep 03 21:32:35 osskil systemd[1]: Stopping Atop advanced performance monitor...
Sep 03 21:32:35 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:35 osskil systemd-logind[643]: Lid closed.
Sep 03 21:32:35 osskil org.gnome.Shell.desktop[715]: Window manager warning: Failed to read EDID of output eDP37: No such file or directory
Sep 03 21:32:36 osskil systemd-logind[643]: Lid opened.
Sep 03 21:32:36 osskil systemd[1]: Stopped Atop advanced performance monitor.
Sep 03 21:32:36 osskil systemd-sleep[16079]: Suspending system...

Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: suspend issues: faulty lid switch?

Marius Gedminas-4
On Sun, Sep 04, 2016 at 10:50:35AM -0400, Matt Price wrote:
> I'm new to the group but have been using Thinkpads for a long time. I'm
> currently running a GNOME desktop with Arch Linux on a T440s, and a
> longstanding intermittent problem with suspend has become much much worse
> in the last few months.
<snip>
> - is there a way to physically fix the lid switch?
> - if not, do you know of a way ot disable the switch entirely? Is that
> handled maybe in /etc/systemd/logind.conf?

I had a T61 with a semi-broken lid switch (it would sometimes randomly
wake up while in my backpack).  I found a software workaround: disable
the lid switch as an ACPI wakeup source by doing

  echo LID > /proc/acpi/wakeup

from a startup script (/etc/rc.local on my Ubuntu).

IIRC what this does is toggle the state. You can cat /proc/acpi/wakeup
to see whether it's currently enabled or not.

HTH,
Marius Gedminas
--
Lovecraft was disappointed that there were no polysyllabic synonyms for "a" and
"the".
        -- Sean O'Hara

signature.asc (180 bytes) Download Attachment
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: suspend issues: faulty lid switch?

Jeffrey L. Taylor-9
In reply to this post by Matt Price
Quoting Matt Price <[hidden email]>:

> Hi everyone,
>
> I'm new to the group but have been using Thinkpads for a long time. I'm
> currently running a GNOME desktop with Arch Linux on a T440s, and a
> longstanding intermittent problem with suspend has become much much worse
> in the last few months.
>
> In the past, I had occasional issues where my laptop would fail to wake
> from suspend, andn eeded to be "hard" reset with the reset button (hte
> pinhole on the bototm of hte laptop). Since there's an internal battery, I
> also had to take apart the laptop and disconnect the battery for the reset
> to work.  At first this happened about once a month; when it became more
> frequent, about once a week, I diconnected the internal battery completely
> to make this easier.
>
[snip]

To help isolate the problem, try suspending from a root command line (s2ram)
or use the desktop environment menus.  I find this reliable.  Just closing the
lib often puts it in a state where it won't wake up.  I don't think I've seen
the wakeup while closed, but I'm not possible.

This is on OpenSuSE 1.31 and a T520.

HTH,
  Jeffrey

P.S. I'll try closing and opening the lid, then look at the system logs.
Thanks for noticing the multiple events.
--
The linux-thinkpad mailing list home page is at:
http://mailman.linux-thinkpad.org/mailman/listinfo/linux-thinkpad
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: suspend issues: faulty lid switch?

Eric Covener
In reply to this post by Matt Price
On Sun, Sep 4, 2016 at 10:50 AM, Matt Price <[hidden email]> wrote:
> In the past, I had occasional issues where my laptop would fail to wake from
> suspend, andn eeded to be "hard" reset with the reset button (hte pinhole on
> the bototm of hte laptop). Since there's an internal battery, I also had to
> take apart the laptop and disconnect the battery for the reset to work.  At
> first this happened about once a month; when it became more frequent, about
> once a week, I diconnected the internal battery completely to make this
> easier.

I have this occasionally and have partially convinced myself it was
related to closing the lid too closely to suspending from the UI /
function keys.   Any chance you're doing this?

--
Eric Covener
[hidden email]
--
The linux-thinkpad mailing list home page is at:
http://mailman.linux-thinkpad.org/mailman/listinfo/linux-thinkpad
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: suspend issues: faulty lid switch?

Jeffrey L. Taylor-9
In reply to this post by Jeffrey L. Taylor-9
Quoting Jeffrey L. Taylor <[hidden email]>:

> Quoting Matt Price <[hidden email]>:
> > Hi everyone,
> >
> > I'm new to the group but have been using Thinkpads for a long time. I'm
> > currently running a GNOME desktop with Arch Linux on a T440s, and a
> > longstanding intermittent problem with suspend has become much much worse
> > in the last few months.
> >
> > In the past, I had occasional issues where my laptop would fail to wake
> > from suspend, andn eeded to be "hard" reset with the reset button (hte
> > pinhole on the bototm of hte laptop). Since there's an internal battery, I
> > also had to take apart the laptop and disconnect the battery for the reset
> > to work.  At first this happened about once a month; when it became more
> > frequent, about once a week, I diconnected the internal battery completely
> > to make this easier.
> >
> [snip]
>
> To help isolate the problem, try suspending from a root command line (s2ram)
> or use the desktop environment menus.  I find this reliable.  Just closing the
> lib often puts it in a state where it won't wake up.  I don't think I've seen
[oops]
> the wakeup while closed, but I'm not positive.
[oops]
>
> This is on OpenSuSE 1.31 and a T520.
>
> HTH,
>   Jeffrey
>
> P.S. I'll try closing and opening the lid, then look at the system logs.
> Thanks for noticing the multiple events.
--
The linux-thinkpad mailing list home page is at:
http://mailman.linux-thinkpad.org/mailman/listinfo/linux-thinkpad
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: suspend issues: faulty lid switch?

Stefan Monnier
In reply to this post by Matt Price
> In the past, I had occasional issues where my laptop would fail to wake
> from suspend, andn eeded to be "hard" reset with the reset button (hte
> pinhole on the bototm of hte laptop). Since there's an internal battery, I
> also had to take apart the laptop and disconnect the battery for the reset
> to work.

That sounds like a hardware (or at most firmware) problem rather than
any kind of software issue.  On all my laptops, keeping the power button
pressed for 4-6s is enough to force a hard power-down.  And this seems
to be handled at a low-enough level that it's pretty much always worked,
even when the kernel is completely borked.


        Stefan

--
The linux-thinkpad mailing list home page is at:
http://mailman.linux-thinkpad.org/mailman/listinfo/linux-thinkpad
Loading...