You are not logged in.
I'm having a weird issue where when my laptop resumes from hibernation, it gets all the way into Xorg and then completely locks up. No keyboard input so I can't unlock i3lock or switch to a TTY session, no mouse, logind doesn't respond to power button being pressed so can't gracefully shut down my laptop either.
Looking through my system logs, I can see the following:
Sep 02 08:35:58 Vili systemd[1]: systemd-suspend-then-hibernate.service: Consumed 12.032s CPU time.
Sep 02 08:35:58 Vili systemd[1]: Stopped target Sleep.
Sep 02 08:35:58 Vili systemd[1]: Reached target Suspend; Hibernate if not used for a period of time.
Sep 02 08:35:58 Vili systemd-logind[929]: Operation 'sleep' finished.
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.3389] manager: sleep: wake requested (sleeping: yes enabled: yes)
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.3392] device (enp0s31f6): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 02 08:35:58 Vili systemd[1]: Starting User resume actions...
Sep 02 08:35:58 Vili systemd[1]: Stopped target Suspend; Hibernate if not used for a period of time.
Sep 02 08:35:58 Vili xrandr[641175]: Can't open display
Sep 02 08:35:58 Vili systemd[1]: resume@vendion.service: Main process exited, code=exited, status=1/FAILURE
Sep 02 08:35:58 Vili mtp-probe[641185]: checking bus 1, device 8: "/sys/devices/pci0000:00/0000:00:14.0/usb1/1-9"
Sep 02 08:35:58 Vili mtp-probe[641185]: bus: 1, device: 8 was not an MTP device
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.5296] device (wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.5736] device (wlan0): set-hw-addr: set MAC address to 6E:55:CC:A1:6E:CE (scanning)
Sep 02 08:35:58 Vili acpid[925]: client connected from 1034[0:0]
Sep 02 08:35:58 Vili acpid[925]: 1 client rule loaded
Sep 02 08:35:58 Vili acpid[925]: client connected from 1034[0:0]
Sep 02 08:35:58 Vili acpid[925]: 1 client rule loaded
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8478] device (p2p-dev-wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8480] manager: NetworkManager state is now DISCONNECTED
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8873] device (wlan0): supplicant interface state: internal-starting -> disconnected
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8873] device (p2p-dev-wlan0): state change: unavailable -> unmanaged (reason 'removed', sys-iface-state: 'removed')
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8879] Wi-Fi P2P device controlled by interface wlan0 created
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8882] manager: (p2p-dev-wlan0): new 802.11 Wi-Fi P2P device (/org/freedesktop/NetworkManager/Devices/13)
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8885] device (p2p-dev-wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8889] device (wlan0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Sep 02 08:35:58 Vili NetworkManager[959]: <info> [1662118558.8893] device (p2p-dev-wlan0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Waiting for firmware download to complete
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Firmware loaded in 1450150 usecs
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Waiting for device to boot
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Device booted in 10785 usecs
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Malformed MSFT vendor event: 0x02
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Applying Intel DDC parameters completed
Sep 02 08:35:59 Vili kernel: Bluetooth: hci0: Firmware revision 0.0 build 14 week 44 2021
Sep 02 08:35:59 Vili NetworkManager[959]: <info> [1662118559.2484] manager: (60:B7:6E:0B:43:03): new Bluetooth device (/org/freedesktop/NetworkManager/Devices/14)
Sep 02 08:35:59 Vili NetworkManager[959]: <info> [1662118559.2487] device (60:B7:6E:0B:43:03): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 02 08:35:59 Vili NetworkManager[959]: <info> [1662118559.2516] device (60:B7:6E:0B:43:03): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/ldac
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSink/aptx_hd
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aptx_hd
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSink/aptx
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aptx
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aac
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSink/sbc
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/sbc
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSink/sbc_xq
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/sbc_xq
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aptx_ll_1
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aptx_ll_0
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_1
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_0
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/faststream
Sep 02 08:35:59 Vili bluetoothd[926]: Endpoint registered: sender=:1.20962 path=/MediaEndpoint/A2DPSource/faststream_duplex
Sep 02 08:35:59 Vili systemd[1]: resume@vendion.service: Failed with result 'exit-code'.
Sep 02 08:35:59 Vili systemd[1]: Failed to start User resume actions.
Sep 02 08:35:59 Vili audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=unconfined msg='unit=resume@vendion comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'
Sep 02 08:36:01 Vili wpa_supplicant[1123]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=BR
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.7755] policy: auto-activating connection 'homewifi_BD8' (d87ff327-516c-46c1-a609-814489d813d3)
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.7760] device (wlan0): Activation: starting connection 'homewifi_BD8' (d87ff327-516c-46c1-a609-814489d813d3)
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.7761] device (wlan0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.7763] manager: NetworkManager state is now CONNECTING
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8215] device (wlan0): set-hw-addr: reset MAC address to B8:8A:60:E2:70:8E (preserve)
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8263] device (wlan0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8267] device (wlan0): Activation: (wifi) access point 'homewifi_BD8' has security, but secrets are required.
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8267] device (wlan0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8269] sup-iface[85fa31fc1693d991,1,wlan0]: wps: type pbc start...
Sep 02 08:36:01 Vili wpa_supplicant[1123]: wlan0: WPS-PBC-ACTIVE
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8637] device (wlan0): supplicant interface state: disconnected -> inactive
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8637] device (p2p-dev-wlan0): supplicant management interface state: disconnected -> inactive
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8686] device (wlan0): supplicant interface state: inactive -> scanning
Sep 02 08:36:01 Vili NetworkManager[959]: <info> [1662118561.8686] device (p2p-dev-wlan0): supplicant management interface state: inactive -> scanning
Sep 02 08:36:02 Vili systemd[1]: systemd-rfkill.service: Deactivated successfully.
Sep 02 08:36:02 Vili audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 02 08:36:06 Vili bluetoothd[926]: src/profile.c:record_cb() Unable to get Hands-Free Voice gateway SDP record: Host is down
Sep 02 08:36:11 Vili kernel: Uhhuh. NMI received for unknown reason 2c on CPU 0.
Sep 02 08:36:11 Vili kernel: Dazed and confused, but trying to continue
Sep 02 08:36:11 Vili bluetoothd[926]: src/profile.c:record_cb() Unable to get Hands-Free Voice gateway SDP record: Host is down
Sep 02 08:36:13 Vili syncthing[1067]: [TC7A2] INFO: Connection to Q7KLDUV-EBH36XK-6KA2TWI-HYSWMAY-FDDKMJG-QMKZJ2U-HP6EFQA-FL6DYAJ at [2804:14c:145:8f28::1]:22000-[2604:a880:800:c1::26f:1]:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256 closed: read timeout
Sep 02 08:36:29 Vili audit[644099]: SYSCALL arch=c000003e syscall=1 success=yes exit=1 a0=3 a1=7ffdad688b60 a2=1 a3=7ffdad688520 items=0 ppid=261605 pid=644099 auid=0 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=110 comm="crond" exe="/usr/sbin/crond" subj=unconfinedkey=(null)
Sep 02 08:36:29 Vili audit: PROCTITLE proctitle=2F7573722F7362696E2F63726F6E64002D6E
Sep 02 08:36:29 Vili audit[644098]: SYSCALL arch=c000003e syscall=1 success=yes exit=1 a0=3 a1=7ffdad688b60 a2=1 a3=7ffdad688520 items=0 ppid=261605 pid=644098 auid=0 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=111 comm="crond" exe="/usr/sbin/crond" subj=unconfinedkey=(null)
Sep 02 08:36:29 Vili audit: PROCTITLE proctitle=2F7573722F7362696E2F63726F6E64002D6EMainly this caught my eye
Sep 02 08:35:59 Vili systemd[1]: resume@vendion.service: Failed with result 'exit-code'.
Sep 02 08:35:59 Vili systemd[1]: Failed to start User resume actions.Checking the logs for that service file shows the following:
-- Boot cee6de90cbb447488dea5ca3b279dd3e --
Sep 02 08:35:58 Vili systemd[1]: Starting User resume actions...
Sep 02 08:35:58 Vili xrandr[641175]: Can't open display
Sep 02 08:35:58 Vili systemd[1]: resume@vendion.service: Main process exited, code=exited, status=1/FAILURE
Sep 02 08:35:59 Vili systemd[1]: resume@vendion.service: Failed with result 'exit-code'.
Sep 02 08:35:59 Vili systemd[1]: Failed to start User resume actions.I don't see why xrandr not being able to open the display would cause this issue though, unless it's just as simple as the service exiting with a non-zero status code.
The closest thing I can find is this thread from over a year ago, but that is regarding ancient Nvidia drivers and have very minimal Xorg configs in /etc/xorg.conf.d. Any help in trying to get to the bottom of this is greatly appricated as I'm getting tied of having to fsck my file systems every time my system hibernates.
Offline
Sep 02 08:36:11 Vili kernel: Uhhuh. NMI received for unknown reason 2c on CPU 0.
Sep 02 08:36:11 Vili kernel: Dazed and confused, but trying to continueThis suggests hardware, as I understand it. The hardware sends the kernel some signal about a problem but the kernel has no way of knowing what's wrong.
What's vendion?
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline
Interesting that was just logged as normal output (not colored like a warning/error in journalctl output) so I missed that. It's worth looking into for sure.
What's vendion?
That is just my username.
Offline
That is just my username.
Sorry - for some reason I was thinking in terms of devices, but it even matches your name here.
I'm not familiar with what this should look like but the question marks in the line below those you picked out might also be worth considering.
Sep 02 08:35:59 Vili audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=unconfined msg='unit=resume@vendion comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'Last edited by cfr (2022-09-03 15:01:34)
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline