"Waiting for process: systemd-udevd" after reboot

[akej74]

Greetings,

I’m on a fresh install of EnOS (KDE) and I get intermittent issues rebooting the system. It hangs with a “Waiting for process: systemd-udevd” error (see screenshots below). Note, this does not happen at every reboot and I haven’t been able to find a reproducible scenario. TTY prompt (CTRL+Alt+F2 / F3) is unresponsive and a hard reset in the only way to shut down the machine.

inxi -FAZ --no-host | eos-sendlog

https://clbin.com/11fwz

I found an older systemd bug report that has been closed for a long time, as well as the following post with a similar issue:

Unable to poweroff, reboot, or hibernate due to a frozen "udev" process

Hello guys! My specs: Laptop ASUS X553MA Kernel: 5.4.10-arch1-1 Processor: 4 Intel Celeron CPU N2930 @1.83GHz I have a dualboot system with 2 harddrives, one for EndeavourOS, one for Windows 10. I have a problem that goes from “I don’t exist” to “I AM NOT GONNA CEASE TO EXIST!” with poweroff mainly, but I am unable to restart, “sleep” or hibernate either. Right now my main concern is that I cannot “normally” poweroff nor restart my laptop and that is really annoying. The weird t…

First I thought secure boot was the root cause (it was enabled when I got the first error message below), but I got the problem again even after disabling secure boot. I have two drives in the machine, EnOS on one and Windows 10 on the other. BIOS is updated to latest version, all settings default except XMP profile enabled for the memory.

Maybe someone can provide some insight into the problem, or ideas for further troubleshooting?

[akej74]

Note that I do have some USB devices connected as follows:

Bus 006 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 005 Device 003: ID 046d:c52b Logitech, Inc. Unifying Receiver
Bus 005 Device 002: ID 0951:1666 Kingston Technology DataTraveler 100 G3/G4/SE9 G2/50
Bus 005 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 004 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 003 Device 007: ID 1b1c:1b8f Corsair CORSAIR K63 Wireless USB Receiver
Bus 003 Device 006: ID 045e:02fe Microsoft Corp. XBOX ACC
Bus 003 Device 005: ID 05e3:0608 Genesys Logic, Inc. Hub
Bus 003 Device 004: ID 1462:7c84 Micro Star International MYSTIC LIGHT 
Bus 003 Device 003: ID 046d:c539 Logitech, Inc. USB Receiver
Bus 003 Device 002: ID 10c4:ea60 Silicon Labs CP210x UART Bridge
Bus 003 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 002: ID 8087:0029 Intel Corp. AX200 Bluetooth
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

[Celty]

I have had this issue on all arch-based installations as well, and never solved it. From the information I have collected I think it is related to a hardware process, like an onboard wifi card or something similar, causing the hangup. Perhaps start disabling devices you do not use in bios, and see if the problem continues. Oh and, if you ever find a solution, do post it here please.

[akej74]

Thanks for the suggestion, I tested removing the following USB dongles:

• XBOX wireless controller
• Logitech wirelss gaming mouse
• Corsair wireless keyboard

My Logitech unified receiver is still connected, as well as regular USB memory.

This indeed seems to have solved the issue (tried several reboots)… But I still have a problem with very long shutdown times.

journalctl log

dec 12 15:09:58 linux dbus-daemon[845]: [session uid=1000 pid=845] Activating service name='org.kde.Shutdown' requested by ':1.16' (uid=1000 pid=957 comm="/usr/bin/plasmashell ")
dec 12 15:09:58 linux dbus-daemon[845]: [session uid=1000 pid=845] Successfully activated service 'org.kde.Shutdown'
dec 12 15:09:58 linux polkit-kde-authentication-agent-1[959]: Destroying listener
dec 12 15:09:58 linux polkit-kde-authentication-agent-1[959]: Removing listener  PolkitQt1::Agent::Listener(0x56535a74a9a0)
dec 12 15:09:58 linux polkitd[767]: Unregistered Authentication Agent for unix-session:2 (system bus name :1.40, object path /org/kde/PolicyKit1/AuthenticationAgent, locale en_US.UTF-8)
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50391, resource id: 37748742, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50400, resource id: 29360133, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50404, resource id: 31457285, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50419, resource id: 44040213, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50423, resource id: 10485765, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50427, resource id: 35651589, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50431, resource id: 27262987, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.desktoptoolbox/contents/ui/ToolBoxButton.qml:209: TypeError: Cannot call method 'globalAction' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.desktoptoolbox/contents/ui/ToolBoxButton.qml:198: TypeError: Cannot call method 'action' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.desktoptoolbox/contents/ui/ToolBoxButton.qml:192: TypeError: Cannot call method 'action' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.desktoptoolbox/contents/ui/ToolBoxButton.qml:20: TypeError: Cannot read property 'editMode' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.desktoptoolbox/contents/ui/ToolBoxButton.qml:33: TypeError: Cannot read property 'editMode' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.desktoptoolbox/contents/ui/ToolBoxButton.qml:34: TypeError: Cannot read property 'editMode' of null
dec 12 15:09:58 linux plasmashell[957]: trying to show an empty dialog
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:63: TypeError: Cannot read property 'pluginName' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:65: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:66: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:67: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:68: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:69: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:20: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:21: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:22: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/wallpapers/org.kde.image/contents/ui/main.qml:23: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.paneltoolbox/contents/ui/main.qml:18: TypeError: Cannot read property 'formFactor' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.paneltoolbox/contents/ui/main.qml:90: TypeError: Cannot read property 'editMode' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.paneltoolbox/contents/ui/main.qml:35: TypeError: Cannot read property 'editMode' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/packages/org.kde.paneltoolbox/contents/ui/main.qml:24: TypeError: Cannot read property 'editMode' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/main.qml:98: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/main.qml:99: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/main.qml:90: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/main.qml:26: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/Tooltip.qml:71: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/Tooltip.qml:60: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/Tooltip.qml:86: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/main.qml:65: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/Tooltip.qml:86: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.digitalclock/contents/ui/main.qml:42: TypeError: Cannot read property 'compactRepresentationItem' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/shells/org.kde.plasma.desktop/contents/applet/CompactApplet.qml:52: TypeError: Cannot read property 'implicitWidth' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/shells/org.kde.plasma.desktop/contents/applet/CompactApplet.qml:70: TypeError: Cannot read property 'implicitHeight' of null
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50436, resource id: 41943064, major code: 15 (QueryTree), minor code: 0
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.kickoff/contents/ui/Kickoff.qml:143: TypeError: Cannot read property 'formFactor' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.kickoff/contents/ui/Kickoff.qml:134: TypeError: Cannot read property 'location' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.kickoff/contents/ui/KickoffSingleton.qml:81: TypeError: Cannot read property 'formFactor' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.kdeconnect/contents/ui/main.qml:38: TypeError: Cannot read property 'formFactor' of null
dec 12 15:09:58 linux dbus-daemon[845]: [session uid=1000 pid=845] Activating service name='org.kde.kdeconnect' requested by ':1.16' (uid=1000 pid=957 comm="/usr/bin/plasmashell ")
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.devicenotifier/contents/ui/devicenotifier.qml:24: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.devicenotifier/contents/ui/devicenotifier.qml:235: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.devicenotifier/contents/ui/devicenotifier.qml:241: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.devicenotifier/contents/ui/devicenotifier.qml:247: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.devicenotifier/contents/ui/devicenotifier.qml:255: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.volume/contents/ui/main.qml:26: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.notifications/contents/ui/main.qml:141: TypeError: Cannot read property 'nativeInterface' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.notifications/contents/ui/global/Globals.qml:65:5: Unable to assign [undefined] to QObject*
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.notifications/contents/ui/global/Globals.qml:162: TypeError: Cannot read property 'nativeInterface' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.battery/contents/ui/batterymonitor.qml:164: TypeError: Cannot read property 'configuration' of null
dec 12 15:09:58 linux plasmashell[957]: file:///usr/share/plasma/plasmoids/org.kde.plasma.networkmanagement/contents/ui/main.qml:69: TypeError: Cannot read property 'expanded' of null
dec 12 15:09:58 linux plasmashell[957]: org.kde.plasma.pulseaudio: No object for name "alsa_output.pci-0000_2f_00.4.analog-stereo"
dec 12 15:09:58 linux plasmashell[957]: org.kde.plasma.pulseaudio: No object for name "alsa_output.pci-0000_2f_00.4.analog-stereo.monitor"
dec 12 15:09:58 linux plasmashell[957]: org.kde.plasma.pulseaudio: No object for name "alsa_output.pci-0000_2f_00.4.analog-stereo"
dec 12 15:09:58 linux plasmashell[957]: org.kde.plasma.pulseaudio: No object for name "alsa_output.pci-0000_2f_00.4.analog-stereo.monitor"
dec 12 15:09:58 linux kwin_x11[886]: QMetaProperty::read: Unable to handle unregistered datatype 'KWin::SessionState' for property 'KWin::EffectsHandlerImplX11::sessionState'
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50653, resource id: 41943216, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux kded5[882]: Service  "org.kde.StatusNotifierHost-957" unregistered
dec 12 15:09:58 linux dbus-daemon[845]: [session uid=1000 pid=845] Successfully activated service 'org.kde.kdeconnect'
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50659, resource id: 54526014, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux systemd[828]: app-org.kde.konsole-978dac00e7d94b9c8eb06155a1f3aa86.scope: Consumed 15.773s CPU time.
dec 12 15:09:58 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 50663, resource id: 27262988, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:09:58 linux dbus-daemon[845]: [session uid=1000 pid=845] Activating service name='org.freedesktop.Notifications' requested by ':1.56' (uid=1000 pid=3448 comm="/usr/lib/kdeconnectd ")
dec 12 15:10:08 linux ksmserver[943]: org.kde.kf5.ksmserver: SmsDie timeout, client  "/usr/lib/kdeconnectd" ( 10e4696e75000163931819800000009430008 )
dec 12 15:10:08 linux kwin_x11[886]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 51891, resource id: 27262989, major code: 18 (ChangeProperty), minor code: 0
dec 12 15:10:08 linux org.kde.kdeconnect[3448]: ICE default IO error handler doing an exit(), pid = 3448, errno = 11
dec 12 15:10:08 linux systemd-logind[565]: System is rebooting.
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux sddm[575]: Authentication error: "Process crashed"
dec 12 15:10:08 linux sddm[575]: Auth: sddm-helper crashed (exit code 15)
dec 12 15:10:08 linux sddm[575]: Authentication error: "Process crashed"
dec 12 15:10:08 linux sddm[575]: Auth: sddm-helper exited with 15
dec 12 15:10:08 linux sddm[575]: Socket server stopping...
dec 12 15:10:08 linux sddm[575]: Socket server stopped.
dec 12 15:10:08 linux sddm[575]: Display server stopping...
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon::management_interface][DEBUG] disconnect_tunnel
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon][DEBUG] Target state Secured => Unsecured
dec 12 15:10:08 linux mullvad-daemon[572]: [talpid_core::dns][INFO] Resetting DNS
dec 12 15:10:08 linux mullvad-daemon[572]: [talpid_core::routing::imp::imp][DEBUG] Clearing routes
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux systemd[1]: Stopping Session 2 of User ake...
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon][DEBUG] New tunnel state: Disconnecting(Nothing)
dec 12 15:10:08 linux systemd[1]: Removed slice Slice /system/getty.
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux systemd[1]: Removed slice Slice /system/modprobe.
dec 12 15:10:08 linux systemd[1]: Stopped target Bluetooth Support.
dec 12 15:10:08 linux systemd[1]: Stopped target Graphical Interface.
dec 12 15:10:08 linux systemd[1]: Stopped target Multi-User System.
dec 12 15:10:08 linux kded5[882]: QDBusAbstractAdaptor: Cannot relay signal KDEDModule::moduleDeleted(KDEDModule*): Pointers are not supported: KDEDModule*
dec 12 15:10:08 linux systemd[1]: Stopped target Login Prompts.
dec 12 15:10:08 linux systemd[1]: Stopped target Sound Card.
dec 12 15:10:08 linux systemd[1]: Stopped target Timer Units.
dec 12 15:10:08 linux systemd[1]: fstrim.timer: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Discard unused blocks once a week.
dec 12 15:10:08 linux systemd[1]: logrotate.timer: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Daily rotation of log files.
dec 12 15:10:08 linux systemd[1]: man-db.timer: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Daily man-db regeneration.
dec 12 15:10:08 linux systemd[1]: shadow.timer: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Daily verification of password and group files.
dec 12 15:10:08 linux systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Daily Cleanup of Temporary Directories.
dec 12 15:10:08 linux systemd[1]: updatedb.timer: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Daily locate database update.
dec 12 15:10:08 linux systemd[1]: Stopped target System Time Set.
dec 12 15:10:08 linux systemd[1]: lvm2-lvmpolld.socket: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Closed LVM2 poll daemon socket.
dec 12 15:10:08 linux systemd[1]: systemd-coredump.socket: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Closed Process Core Dump Socket.
dec 12 15:10:08 linux systemd[1]: systemd-rfkill.socket: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
dec 12 15:10:08 linux systemd[1]: Stopping Save/Restore Sound Card State...
dec 12 15:10:08 linux avahi-daemon[562]: Got SIGTERM, quitting.
dec 12 15:10:08 linux avahi-daemon[562]: Leaving mDNS multicast group on interface enp38s0.IPv6 with address fe80::468c:a127:f7a5:b2e6.
dec 12 15:10:08 linux systemd[1]: Stopping Avahi mDNS/DNS-SD Stack...
dec 12 15:10:08 linux avahi-daemon[562]: Leaving mDNS multicast group on interface enp38s0.IPv4 with address 192.168.1.100.
dec 12 15:10:08 linux avahi-daemon[562]: Leaving mDNS multicast group on interface lo.IPv6 with address ::1.
dec 12 15:10:08 linux avahi-daemon[562]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
dec 12 15:10:08 linux systemd[1]: Starting Generate shutdown-ramfs...
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon::shutdown::platform][DEBUG] Process received signal: [Term]
dec 12 15:10:08 linux NetworkManager[564]: <info>  [1639318208.5388] device (wg-mullvad): state change: activated -> unmanaged (reason 'unmanaged', sys-iface-state: 'removed')
dec 12 15:10:08 linux systemd[1]: Stopping Mullvad VPN daemon...
dec 12 15:10:08 linux systemd[1]: Stopping Authorization Manager...
dec 12 15:10:08 linux systemd[1]: Stopping Power Profiles daemon...
dec 12 15:10:08 linux systemd[1]: Stopping RealtimeKit Scheduling Policy Service...
dec 12 15:10:08 linux systemd[1]: Stopping Simple Desktop Display Manager...
dec 12 15:10:08 linux systemd[1]: Stopping Load/Save Random Seed...
dec 12 15:10:08 linux systemd[1]: Stopping Disk Manager...
dec 12 15:10:08 linux systemd[1]: Stopping Daemon for power management...
dec 12 15:10:08 linux dbus-daemon[563]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=564 comm="/usr/bin/NetworkManager --no-daemon ")
dec 12 15:10:08 linux systemd[1]: upower.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Daemon for power management.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=upower comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux systemd[1]: power-profiles-daemon.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Power Profiles daemon.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=power-profiles-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kded5[882]: The X11 connection broke: I/O error (code 1)
dec 12 15:10:08 linux systemd[1]: rtkit-daemon.service: Deactivated successfully.
dec 12 15:10:08 linux kwin_x11[886]: The X11 connection broke: I/O error (code 1)
dec 12 15:10:08 linux systemd[1]: Stopped RealtimeKit Scheduling Policy Service.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=rtkit-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kwin_x11[886]: QObject::~QObject: Timers cannot be stopped from another thread
dec 12 15:10:08 linux systemd[1]: alsa-restore.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Save/Restore Sound Card State.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=alsa-restore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.537:86): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=upower comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.537:87): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=power-profiles-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.537:88): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=rtkit-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.537:89): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=alsa-restore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kglobalaccel5[916]: The X11 connection broke (error 1). Did the X11 server die?
dec 12 15:10:08 linux systemd-logind[565]: Session 2 logged out. Waiting for processes to exit.
dec 12 15:10:08 linux dbus-daemon[563]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.nm-dispatcher.service': Refusing activation, D-Bus is shutting down.
dec 12 15:10:08 linux mkinitcpio[3466]: ==> Starting build: none
dec 12 15:10:08 linux kscreen_backend_launcher[988]: The X11 connection broke (error 1). Did the X11 server die?
dec 12 15:10:08 linux kactivitymanagerd[1004]: The X11 connection broke (error 1). Did the X11 server die?
dec 12 15:10:08 linux systemd[1]: systemd-random-seed.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Load/Save Random Seed.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux at-spi-bus-launcher[1696]: X connection to :0 broken (explicit kill or server shutdown).
dec 12 15:10:08 linux mkinitcpio[3466]:   -> Running build hook: [sd-shutdown]
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.547:90): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux avahi-daemon[562]: avahi-daemon 0.8 exiting.
dec 12 15:10:08 linux udisksd[768]: udisks daemon version 2.9.4 exiting
dec 12 15:10:08 linux systemd[1]: avahi-daemon.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Avahi mDNS/DNS-SD Stack.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=avahi-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.557:91): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=avahi-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:10:08 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:10:08 linux kernel: audit: type=1334 audit(1639318208.564:92): prog-id=0 op=UNLOAD
dec 12 15:10:08 linux kernel: audit: type=1334 audit(1639318208.564:93): prog-id=0 op=UNLOAD
dec 12 15:10:08 linux systemd[1]: polkit.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Authorization Manager.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=polkit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux systemd[1]: udisks2.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Stopped Disk Manager.
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=udisks2 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.577:94): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=polkit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux kernel: audit: type=1131 audit(1639318208.577:95): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=udisks2 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux mkinitcpio[3466]: ==> Build complete.
dec 12 15:10:08 linux systemd[1]: mkinitcpio-generate-shutdown-ramfs.service: Deactivated successfully.
dec 12 15:10:08 linux systemd[1]: Finished Generate shutdown-ramfs.
dec 12 15:10:08 linux audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=mkinitcpio-generate-shutdown-ramfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=mkinitcpio-generate-shutdown-ramfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux pipewire-media-session[1313]: ms.mod.default-profile: device 'alsa_card.pci-0000_2d_00.1': can't restore profile: No such device
dec 12 15:10:08 linux sddm[575]: Display server stopped.
dec 12 15:10:08 linux sddm[575]: Running display stop script  "/usr/share/sddm/scripts/Xstop"
dec 12 15:10:08 linux sddm[575]: Removing display ":0" ...
dec 12 15:10:08 linux sddm[575]: Adding new display on vt 1 ...
dec 12 15:10:08 linux sddm[575]: Loading theme configuration from ""
dec 12 15:10:08 linux sddm[575]: Display server starting...
dec 12 15:10:08 linux sddm[575]: Adding cookie to "/var/run/sddm/{36287dc3-42dc-47fd-b693-b15f243f60a8}"
dec 12 15:10:08 linux sddm[575]: Running: /usr/bin/X -nolisten tcp -background none -seat seat0 vt1 -auth /var/run/sddm/{36287dc3-42dc-47fd-b693-b15f243f60a8} -noreset -displayfd 18
dec 12 15:10:08 linux mullvad-daemon[572]: [talpid_core::tunnel_state_machine::connecting_state][DEBUG] Tunnel monitor exited with block reason: None
dec 12 15:10:08 linux mullvad-daemon[572]: [talpid_core::firewall][INFO] Resetting firewall policy
dec 12 15:10:08 linux mullvad-daemon[572]: [talpid_core::firewall::imp][DEBUG] Removing table and chain from netfilter
dec 12 15:10:08 linux audit[713]: NETFILTER_CFG table=mullvadmangle6:6 family=10 entries=6 op=nft_unregister_table pid=713 comm="mullvad-daemon"
dec 12 15:10:08 linux audit[713]: NETFILTER_CFG table=mullvadmangle4:6 family=2 entries=8 op=nft_unregister_table pid=713 comm="mullvad-daemon"
dec 12 15:10:08 linux audit[713]: NETFILTER_CFG table=mullvad:6 family=1 entries=90 op=nft_unregister_table pid=713 comm="mullvad-daemon"
dec 12 15:10:08 linux audit[572]: SYSCALL arch=c000003e syscall=44 success=yes exit=312 a0=e a1=7f8c1404b2f0 a2=138 a3=0 items=0 ppid=1 pid=572 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="mullvad-daemon" exe=2F6F70742F4D756C6C7661642056504E2F7265736F75726365732F6D756C6C7661642D6461656D6F6E key=(null)
dec 12 15:10:08 linux audit: PROCTITLE proctitle=2F6F70742F4D756C6C7661642056504E2F7265736F75726365732F6D756C6C7661642D6461656D6F6E002D76002D2D64697361626C652D7374646F75742D74696D657374616D7073
dec 12 15:10:08 linux NetworkManager[564]: <info>  [1639318208.8162] config: signal: SET_VALUES,values,values-intern,connectivity (/etc/NetworkManager/NetworkManager.conf (lib: 20-connectivity.conf))
dec 12 15:10:08 linux audit[564]: USYS_CONFIG pid=564 uid=0 auid=4294967295 ses=4294967295 msg='op=networking-control arg="connectivity-check-enabled:on" pid=572 uid=0 result=success exe="/usr/bin/NetworkManager" hostname=? addr=? terminal=? res=success'
dec 12 15:10:08 linux NetworkManager[564]: <info>  [1639318208.8163] audit: op="networking-control" arg="connectivity-check-enabled:on" pid=572 uid=0 result="success"
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon][DEBUG] New tunnel state: Disconnected
dec 12 15:10:08 linux mullvad-daemon[572]: [talpid_core::tunnel_state_machine][DEBUG] Exiting tunnel state machine loop
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon::relays][ERROR] Relay list updater shutting down
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon][INFO] Tunnel state machine shut down
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon::management_interface][INFO] Management interface shut down
dec 12 15:10:08 linux mullvad-daemon[572]: [mullvad_daemon][INFO] Mullvad daemon is quitting
dec 12 15:10:08 linux pipewire-media-session[1313]: ms.mod.default-profile: device 'alsa_card.pci-0000_2d_00.1': can't restore profile: No such device
dec 12 15:10:09 linux mullvad-daemon[572]: [mullvad_daemon][DEBUG] Process exiting with code 0
dec 12 15:10:09 linux systemd[1]: mullvad-daemon.service: Deactivated successfully.
dec 12 15:10:09 linux systemd[1]: Stopped Mullvad VPN daemon.
dec 12 15:10:09 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=mullvad-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:10 linux sddm[575]: Setting default cursor
dec 12 15:10:10 linux sddm[575]: Running display setup script  "/usr/share/sddm/scripts/Xsetup"
dec 12 15:10:10 linux sddm[575]: Display server started.
dec 12 15:10:10 linux sddm[575]: Socket server starting...
dec 12 15:10:10 linux sddm[575]: Socket server started.
dec 12 15:10:10 linux sddm[575]: Loading theme configuration from "/usr/share/sddm/themes/breeze/theme.conf"
dec 12 15:10:10 linux sddm[575]: Greeter starting...
dec 12 15:10:10 linux sddm[575]: Signal received: SIGTERM
dec 12 15:10:10 linux sddm[575]: Socket server stopping...
dec 12 15:10:10 linux sddm[575]: Socket server stopped.
dec 12 15:10:10 linux sddm[575]: Display server stopping...
dec 12 15:10:10 linux sddm-helper[3579]: [PAM] Starting...
dec 12 15:10:10 linux sddm-helper[3579]: [PAM] Authenticating...
dec 12 15:10:10 linux audit[3579]: USER_AUTH pid=3579 uid=0 auid=4294967295 ses=4294967295 msg='op=PAM:authentication grantors=pam_permit acct="sddm" exe="/usr/lib/sddm/sddm-helper" hostname=? addr=? terminal=? res=success'
dec 12 15:10:10 linux audit[3579]: USER_ACCT pid=3579 uid=0 auid=4294967295 ses=4294967295 msg='op=PAM:accounting grantors=pam_permit acct="sddm" exe="/usr/lib/sddm/sddm-helper" hostname=? addr=? terminal=? res=success'
dec 12 15:10:10 linux sddm-helper[3579]: [PAM] returning.
dec 12 15:10:10 linux pipewire-media-session[1313]: ms.mod.default-profile: device 'alsa_card.pci-0000_2d_00.1': can't restore profile: No such device
dec 12 15:10:10 linux sddm[575]: Display server stopped.
dec 12 15:10:10 linux sddm[575]: Running display stop script  "/usr/share/sddm/scripts/Xstop"
dec 12 15:10:10 linux sddm[575]: QProcess: Destroyed while process ("/usr/lib/sddm/sddm-helper") is still running.
dec 12 15:10:10 linux systemd[1]: sddm.service: Deactivated successfully.
dec 12 15:10:10 linux systemd[1]: Stopped Simple Desktop Display Manager.
dec 12 15:10:10 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=sddm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:10:10 linux systemd[1]: sddm.service: Consumed 25.128s CPU time.
dec 12 15:10:58 linux plasma_waitforname[3453]: org.kde.knotifications: WaitForName: Service was not registered within timeout
dec 12 15:10:58 linux dbus-daemon[845]: [session uid=1000 pid=845] Activated service 'org.freedesktop.Notifications' failed: Process org.freedesktop.Notifications exited with status 1
dec 12 15:11:38 linux systemd[1]: session-2.scope: Stopping timed out. Killing.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 882 (kded5) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 886 (kwin_x11) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 884 (QDBusConnection) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 887 (gmain) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 888 (gdbus) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 920 (dconf worker) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 949 (Qt bearer threa) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 951 (QQmlThread) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 953 (kded5) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 1130 (CPMMListener) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Killing process 2294 (QSGRenderThread) with signal SIGKILL.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Failed with result 'timeout'.
dec 12 15:11:38 linux systemd[1]: Stopped Session 2 of User ake.
dec 12 15:11:38 linux systemd[1]: session-2.scope: Consumed 32.103s CPU time.
dec 12 15:11:38 linux systemd[1]: Stopping User Login Management...
dec 12 15:11:38 linux systemd[1]: Stopping User Manager for UID 1000...
dec 12 15:11:38 linux systemd[828]: Removed slice User Background Tasks Slice.
dec 12 15:11:38 linux systemd[828]: Stopped target Main User Target.
dec 12 15:11:38 linux systemd[828]: Stopping Accessibility services bus...
dec 12 15:11:38 linux systemd[828]: Stopping D-Bus User Message Bus...
dec 12 15:11:38 linux systemd[828]: Stopping User preferences database...
dec 12 15:11:38 linux systemd[828]: Stopping PipeWire PulseAudio...
dec 12 15:11:38 linux systemd[828]: Stopped User preferences database.
dec 12 15:11:38 linux systemd[828]: Stopped PipeWire PulseAudio.
dec 12 15:11:38 linux systemd[828]: Stopping PipeWire Media Session Manager...
dec 12 15:11:38 linux systemd[828]: Stopped D-Bus User Message Bus.
dec 12 15:11:38 linux systemd[828]: Stopped Accessibility services bus.
dec 12 15:11:38 linux systemd[828]: Stopped PipeWire Media Session Manager.
dec 12 15:11:38 linux systemd[828]: Stopping PipeWire Multimedia Service...
dec 12 15:11:38 linux systemd[828]: Stopped PipeWire Multimedia Service.
dec 12 15:11:38 linux systemd[828]: Removed slice User Core Session Slice.
dec 12 15:11:38 linux systemd[828]: Stopped target Basic System.
dec 12 15:11:38 linux systemd[828]: Stopped target Paths.
dec 12 15:11:38 linux systemd[828]: Stopped target Sockets.
dec 12 15:11:38 linux systemd[828]: Stopped target Timers.
dec 12 15:11:38 linux systemd[828]: Stopped Run EOS update notifier periodically.
dec 12 15:11:38 linux systemd[828]: Closed D-Bus User Message Bus Socket.
dec 12 15:11:38 linux systemd[828]: Closed GnuPG network certificate management daemon.
dec 12 15:11:38 linux systemd[828]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
dec 12 15:11:38 linux systemd[828]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
dec 12 15:11:38 linux systemd[828]: Closed GnuPG cryptographic agent (ssh-agent emulation).
dec 12 15:11:38 linux systemd[828]: Closed GnuPG cryptographic agent and passphrase cache.
dec 12 15:11:38 linux systemd[828]: Closed p11-kit server.
dec 12 15:11:38 linux systemd[828]: Closed PipeWire PulseAudio.
dec 12 15:11:38 linux systemd[828]: Closed Multimedia System.
dec 12 15:11:38 linux systemd[828]: Removed slice User Application Slice.
dec 12 15:11:38 linux systemd[828]: app.slice: Consumed 2min 19.046s CPU time.
dec 12 15:11:38 linux systemd[828]: Reached target Shutdown.
dec 12 15:11:38 linux systemd[828]: Finished Exit the Session.
dec 12 15:11:38 linux systemd[828]: Reached target Exit the Session.
dec 12 15:11:38 linux systemd[829]: pam_warn(systemd-user:setcred): function=[pam_sm_setcred] flags=0x8004 service=[systemd-user] terminal=[] user=[ake] ruser=[<unknown>] rhost=[<unknown>]
dec 12 15:11:38 linux systemd[1]: user@1000.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped User Manager for UID 1000.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=user@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: user@1000.service: Consumed 2min 20.074s CPU time.
dec 12 15:11:38 linux systemd[1]: Stopping User Runtime Directory /run/user/1000...
dec 12 15:11:38 linux kernel: kauditd_printk_skb: 12 callbacks suppressed
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.824:104): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=user@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: run-user-1000.mount: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Unmounted /run/user/1000.
dec 12 15:11:38 linux systemd[1]: user-runtime-dir@1000.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped User Runtime Directory /run/user/1000.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=user-runtime-dir@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Removed slice User Slice of UID 1000.
dec 12 15:11:38 linux systemd[1]: user-1000.slice: Consumed 2min 52.183s CPU time.
dec 12 15:11:38 linux systemd[1]: Stopping Permit User Sessions...
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.871:105): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=user-runtime-dir@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: systemd-user-sessions.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Permit User Sessions.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-user-sessions comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Stopped target Network.
dec 12 15:11:38 linux systemd[1]: Stopped target Remote File Systems.
dec 12 15:11:38 linux systemd[1]: Stopping Network Manager...
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.8773] caught SIGTERM, shutting down normally.
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.874:106): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-user-sessions comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.9040] dhcp4 (enp38s0): canceled DHCP transaction
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.9040] dhcp4 (enp38s0): state changed bound -> terminated
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.9041] dhcp6 (enp38s0): canceled DHCP transaction
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.9041] dhcp6 (enp38s0): state changed timeout -> terminated
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.9042] manager: NetworkManager state is now CONNECTED_SITE
dec 12 15:11:38 linux dbus-daemon[563]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=564 comm="/usr/bin/NetworkManager --no-daemon ")
dec 12 15:11:38 linux dbus-daemon[563]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.nm-dispatcher.service': Refusing activation, D-Bus is shutting down.
dec 12 15:11:38 linux systemd[1]: systemd-logind.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped User Login Management.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-logind comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.914:107): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-logind comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux NetworkManager[564]: <info>  [1639318298.9271] exiting (success)
dec 12 15:11:38 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:38 linux kernel: audit: type=1334 audit(1639318298.941:108): prog-id=0 op=UNLOAD
dec 12 15:11:38 linux systemd[1]: NetworkManager.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Network Manager.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Stopping D-Bus System Message Bus...
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.947:109): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: dbus.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped D-Bus System Message Bus.
dec 12 15:11:38 linux systemd[1]: dbus.service: Consumed 3.173s CPU time.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=dbus comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Stopped target Basic System.
dec 12 15:11:38 linux systemd[1]: Stopped target Path Units.
dec 12 15:11:38 linux systemd[1]: Stopped target Slice Units.
dec 12 15:11:38 linux systemd[1]: Removed slice User and Session Slice.
dec 12 15:11:38 linux systemd[1]: user.slice: Consumed 2min 52.961s CPU time.
dec 12 15:11:38 linux systemd[1]: Stopped target Socket Units.
dec 12 15:11:38 linux systemd[1]: avahi-daemon.socket: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Closed Avahi mDNS/DNS-SD Stack Activation Socket.
dec 12 15:11:38 linux systemd[1]: dbus.socket: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Closed D-Bus System Message Bus Socket.
dec 12 15:11:38 linux systemd[1]: Stopped target System Initialization.
dec 12 15:11:38 linux systemd[1]: Stopped target Local Encrypted Volumes.
dec 12 15:11:38 linux systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
dec 12 15:11:38 linux systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.961:110): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=dbus comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
dec 12 15:11:38 linux systemd[1]: Stopped target Local Verity Protected Volumes.
dec 12 15:11:38 linux systemd[1]: Stopping Set Up Additional Binary Formats...
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: systemd-sysctl.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Apply Kernel Variables.
dec 12 15:11:38 linux systemd[1]: systemd-modules-load.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Load Kernel Modules.
dec 12 15:11:38 linux systemd[1]: Stopping Network Time Synchronization...
dec 12 15:11:38 linux systemd[1]: Stopping Record System Boot/Shutdown in UTMP...
dec 12 15:11:38 linux systemd[1]: systemd-binfmt.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Set Up Additional Binary Formats.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-binfmt comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully.
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.974:111): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.974:112): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux kernel: audit: type=1131 audit(1639318298.974:113): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-binfmt comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point.
dec 12 15:11:38 linux systemd[1]: proc-sys-fs-binfmt_misc.mount: Deactivated successfully.
dec 12 15:11:38 linux audit[3608]: SYSTEM_SHUTDOWN pid=3608 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: systemd-update-utmp.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Record System Boot/Shutdown in UTMP.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: systemd-timesyncd.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Network Time Synchronization.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Create Volatile Files and Directories.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Stopped target Local File Systems.
dec 12 15:11:38 linux systemd[1]: Unmounting /boot/efi...
dec 12 15:11:38 linux systemd[1]: Unmounting Temporary Directory /tmp...
dec 12 15:11:38 linux systemd[1]: tmp.mount: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Unmounted Temporary Directory /tmp.
dec 12 15:11:38 linux systemd[1]: Stopped target Swaps.
dec 12 15:11:38 linux systemd[1]: Deactivating swap /dev/disk/by-id/nvme-Samsung_SSD_960_EVO_500GB_S3EUNX0HC03271T-part3...
dec 12 15:11:38 linux systemd[1]: boot-efi.mount: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Unmounted /boot/efi.
dec 12 15:11:38 linux systemd[1]: systemd-fsck@dev-disk-by\x2duuid-F2CD\x2d9757.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped File System Check on /dev/disk/by-uuid/F2CD-9757.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-fsck@dev-disk-by\x2duuid-F2CD\x2d9757 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Removed slice Slice /system/systemd-fsck.
dec 12 15:11:38 linux systemd[1]: Stopped target Preparation for Local File Systems.
dec 12 15:11:38 linux systemd[1]: Stopping Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
dec 12 15:11:38 linux systemd[1]: systemd-remount-fs.service: Deactivated successfully.
dec 12 15:11:38 linux systemd[1]: Stopped Remount Root and Kernel File Systems.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
dec 12 15:11:38 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:38 linux systemd[1]: Stopped Create Static Device Nodes in /dev.
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux systemd[1]: dev-disk-by\x2did-nvme\x2deui.0025385c61b02c08\x2dpart3.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/disk/by-id/nvme-eui.0025385c61b02c08-part3.
dec 12 15:11:39 linux systemd[1]: dev-disk-by\x2did-nvme\x2dSamsung_SSD_960_EVO_500GB_S3EUNX0HC03271T\x2dpart3.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/disk/by-id/nvme-Samsung_SSD_960_EVO_500GB_S3EUNX0HC03271T-part3.
dec 12 15:11:39 linux systemd[1]: dev-disk-by\x2dlabel-swap.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/disk/by-label/swap.
dec 12 15:11:39 linux systemd[1]: dev-disk-by\x2dpartuuid-28248d94\x2dc6f4\x2d6745\x2d861b\x2dae3658a16e51.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/disk/by-partuuid/28248d94-c6f4-6745-861b-ae3658a16e51.
dec 12 15:11:39 linux systemd[1]: dev-disk-by\x2dpath-pci\x2d0000:23:00.0\x2dnvme\x2d1\x2dpart3.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/disk/by-path/pci-0000:23:00.0-nvme-1-part3.
dec 12 15:11:39 linux systemd[1]: dev-nvme1n1p3.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/nvme1n1p3.
dec 12 15:11:39 linux systemd[1]: dev-disk-by\x2duuid-c9c38f2b\x2d8d16\x2d4d9c\x2db68c\x2d6432113ce89a.swap: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Deactivated swap /dev/disk/by-uuid/c9c38f2b-8d16-4d9c-b68c-6432113ce89a.
dec 12 15:11:39 linux systemd[1]: Reached target Unmount All Filesystems.
dec 12 15:11:39 linux systemd[1]: lvm2-monitor.service: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Stopped Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
dec 12 15:11:39 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=lvm2-monitor comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:39 linux systemd[1]: Reached target System Shutdown.
dec 12 15:11:39 linux systemd[1]: Reached target Late Shutdown Services.
dec 12 15:11:39 linux systemd[1]: systemd-reboot.service: Deactivated successfully.
dec 12 15:11:39 linux systemd[1]: Finished System Reboot.
dec 12 15:11:39 linux audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-reboot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:39 linux audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-reboot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
dec 12 15:11:39 linux systemd[1]: Reached target System Reboot.
dec 12 15:11:39 linux systemd[1]: Shutting down.
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux audit: BPF prog-id=0 op=UNLOAD
dec 12 15:11:39 linux systemd-shutdown[1]: Syncing filesystems and block devices.
dec 12 15:11:39 linux systemd-shutdown[1]: Sending SIGTERM to remaining processes...
dec 12 15:11:39 linux systemd-journald[426]: Journal stopped

In the log, there are several long delays before the shutdown/reboot is complete:

• 15:09:58 → 15:10:08
• 15:10:10 → 15:10:58
• 15:10:58 → 15:11:38

Any ide what could be causing this…? It’s a bit annoying .

[KDen]

If I remember correctly it’s nvidia related.
Try editing /etc/mkinitcpio.conf and adding shutdown to your hooks
Then regenerate it sudo mkinitcpio -P and reboot

[akej74]

Thanks @KDen, this indeed solved the issue! Note that the first and second reboot after the change was still slow, but after that the system shutdowns quickly. I wonder why it took two reboots until it took effect…

Is there any drawback adding this parameter the hooks…? I did check the Arch wiki, but found no details about this hook.
https://wiki.archlinux.org/title/mkinitcpio

[KDen]

It’s an old bug that was supposed to have been fixed upstream. But, well, Nvidia…
You can read about it here: https://bugs.archlinux.org/task/63697

[KDen]

Basically nvidia is not unloading it’s modules properly. The shutdown hook is calling a little script to run at shutdown that will ensure all modules get unloaded at shutdown. You can see the hook here:

hooks/shutdown · master · Mkinitcpio / mkinitcpio · GitLab

[Celty]

@akej74

Thanks for the suggestion, I tested removing the following USB dongles:

• XBOX wireless controller
• Logitech wirelss gaming mouse
• Corsair wireless keyboard

My Logitech unified receiver is still connected, as well as regular USB memory.

This indeed seems to have solved the issue (tried several reboots)

Glad to hear it. I have both an XBOX wireless, and a Logitech G Pro receiver connected. After removing the XBOX receiver the issue seems to have disappeared for me as well (I did five reboots without an interruption). Hoping it doesn’t return. Not too big an effort to have to plug it in when I want to use it, but it would of course be preferable to have it in at all times.

[akej74]

Hmm, the shutdown delay is back, is a somewhat different way, I get the below error after about 2 min:

Unmouting all devices.
umount: /oldroot/sys: target is busy.
Detaching loop devices.
Disassembling stacked devices.

After this system shuts down. The shutdown hook is still in place, as discussed above. I found several discussions about this (linked below). Any new ideas to try? Maybe not related to nVidia?

If binfmts with the 'F' flag are registered through systemd-binfmt, the root filesystem fails to unmount during shutdown

https://forums.linuxmint.com/viewtopic.php?t=342142