Slow Shutdown since Testing Update 2019-03-10 with Kernel 5.0.1

Easy way: keep using 4.20 for now. Check again 5.0 each time it gets an update.

Harder way: investigate more deeply. From your image there is some problem unmounting /var/log but your journalctl output contains only the last few lines and does not tell us anything about this (it is also truncated at the end of long lines). :face_with_monocle:

1 Like

To add here … kernel 5.0 is very new … do you have a reason to use it?

1 Like

Well, /var/log is mounted to subvolume @log
This is a problem with journald storage=persist, i have to live with that.

https://bbs.archlinux.org/viewtopic.php?pid=1204644#p1204644

oh sorry, my fault

full output
-- Logs begin at Sat 2019-01-26 07:33:33 CET, end at Mon 2019-03-11 19:55:47 CET. --
Mär 11 16:00:44 GBi7 systemd-logind[771]: System is powering down.
Mär 11 16:00:44 GBi7 systemd[861]: at-spi-dbus-bus.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Removed slice system-getty.slice.
Mär 11 16:00:44 GBi7 systemd[1]: Stopping CUPS Scheduler...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping RealtimeKit Scheduling Policy Service...
Mär 11 16:00:44 GBi7 systemd[1]: Stopped target Sound Card.
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Manage, Install and Generate Color Profiles...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Session 1 of user nrittsti.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped target Graphical Interface.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped target Multi-User System.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped target Login Prompts.
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Daemon for power management...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Accounts Service...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Disk Manager...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Authorization Manager...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Light Display Manager...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Snappy daemon...
Mär 11 16:00:44 GBi7 snapd[776]: main.go:147: Exiting on terminated signal.
Mär 11 16:00:44 GBi7 dbus-daemon[773]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.13' (uid=0 pid=775 comm="/usr/bin/NetworkManager --no-daemon ")
Mär 11 16:00:44 GBi7 udisksd[1099]: udisks daemon version 2.8.1 exiting
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Initialize hardware monitoring sensors...
Mär 11 16:00:44 GBi7 gnome-terminal-[1561]: gnome-terminal-server: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.
Mär 11 16:00:44 GBi7 systemd[861]: gnome-terminal-server.service: Main process exited, code=exited, status=1/FAILURE
Mär 11 16:00:44 GBi7 systemd[861]: gnome-terminal-server.service: Failed with result 'exit-code'.
Mär 11 16:00:44 GBi7 systemd[1]: Starting Generate shutdown-ramfs...
Mär 11 16:00:44 GBi7 systemd[1]: lvm2-lvmpolld.socket: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Closed LVM2 poll daemon socket.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped target Timers.
Mär 11 16:00:44 GBi7 systemd[1]: logrotate.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Daily rotation of log files.
Mär 11 16:00:44 GBi7 systemd[1]: pamac-mirrorlist.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Generate mirrorlist weekly.
Mär 11 16:00:44 GBi7 systemd[1]: pamac-cleancache.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Monthly clean packages cache.
Mär 11 16:00:44 GBi7 systemd[1]: systemd-tmpfiles-clean.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Mär 11 16:00:44 GBi7 systemd[1]: fstrim.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Discard unused blocks once a week.
Mär 11 16:00:44 GBi7 systemd[1]: man-db.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Daily man-db regeneration.
Mär 11 16:00:44 GBi7 systemd[1]: shadow.timer: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Daily verification of password and group files.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped target System Time Synchronized.
Mär 11 16:00:44 GBi7 systemd[1]: snapd.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Snappy daemon.
Mär 11 16:00:44 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=snapd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 systemd[1]: org.cups.cupsd.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped CUPS Scheduler.
Mär 11 16:00:44 GBi7 audit[856]: USER_LOGOUT pid=856 uid=0 auid=1000 ses=1 msg='op=logout id=1000 exe="/usr/bin/lightdm" hostname=GBi7 addr=? terminal=/dev/tty7 res=success'
Mär 11 16:00:44 GBi7 lightdm[856]: pam_unix(lightdm-autologin:session): session closed for user nrittsti
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.943:70): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=snapd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 kernel: audit: type=1113 audit(1552316444.943:71): pid=856 uid=0 auid=1000 ses=1 msg='op=logout id=1000 exe="/usr/bin/lightdm" hostname=GBi7 addr=? terminal=/dev/tty7 res=success'
Mär 11 16:00:44 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=org.cups.cupsd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 systemd[1]: colord.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[1]: colord.service: Succeeded.
Mär 11 16:00:44 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=colord comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Manage, Install and Generate Color Profiles.
Mär 11 16:00:44 GBi7 systemd[1]: polkit.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[1]: polkit.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Authorization Manager.
Mär 11 16:00:44 GBi7 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'
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.953:72): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=org.cups.cupsd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.953:73): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=colord comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.953:74): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=polkit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 systemd[1]: accounts-daemon.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Accounts Service.
Mär 11 16:00:44 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=accounts-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 systemd[1]: rtkit-daemon.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[1]: rtkit-daemon.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped RealtimeKit Scheduling Policy Service.
Mär 11 16:00:44 GBi7 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'
Mär 11 16:00:44 GBi7 systemd[1]: upower.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[1]: upower.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Daemon for power management.
Mär 11 16:00:44 GBi7 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'
Mär 11 16:00:44 GBi7 systemd[1]: udisks2.service: Succeeded.
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.953:75): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=accounts-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.953:76): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=rtkit-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.953:77): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=upower comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Disk Manager.
Mär 11 16:00:44 GBi7 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'
Mär 11 16:00:44 GBi7 systemd[1]: lm_sensors.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Initialize hardware monitoring sensors.
Mär 11 16:00:44 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=lm_sensors comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 mkinitcpio[2198]: ==> Starting build: none
Mär 11 16:00:44 GBi7 dbus-daemon[773]: [system] Activation via systemd failed for unit 'polkit.service': Refusing activation, D-Bus is shutting down.
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.956:78): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=udisks2 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 kernel: audit: type=1131 audit(1552316444.956:79): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=lm_sensors comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:44 GBi7 mkinitcpio[2198]:   -> Running build hook: [sd-shutdown]
Mär 11 16:00:44 GBi7 systemd[1]: session-1.scope: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Stopped Session 1 of user nrittsti.
Mär 11 16:00:44 GBi7 systemd[1]: Stopping Login Service...
Mär 11 16:00:44 GBi7 systemd[1]: Stopping User Manager for UID 1000...
Mär 11 16:00:44 GBi7 systemd-logind[771]: Removed session 1.
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Virtual filesystem service - digital camera monitor...
Mär 11 16:00:44 GBi7 gvfsd[960]: A connection to the bus can't be made
Mär 11 16:00:44 GBi7 systemd[861]: Stopping D-Bus User Message Bus...
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Virtual filesystem service - Media Transfer Protocol monitor...
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Sound Service...
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Virtual filesystem metadata service...
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Virtual filesystem service - disk device monitor...
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Virtual filesystem service...
Mär 11 16:00:44 GBi7 systemd[861]: Stopped target Default.
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Cloud Storage Sync Daemon...
Mär 11 16:00:44 GBi7 systemd[861]: Stopping Profile-sync-daemon...
Mär 11 16:00:44 GBi7 systemd[1]: run-user-1000-gvfs.mount: Succeeded.
Mär 11 16:00:44 GBi7 systemd[1]: Unmounted /run/user/1000/gvfs.
Mär 11 16:00:44 GBi7 systemd[861]: run-user-1000-gvfs.mount: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-daemon.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-udisks2-volume-monitor.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-udisks2-volume-monitor.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Virtual filesystem service - disk device monitor.
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-mtp-volume-monitor.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-mtp-volume-monitor.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Virtual filesystem service - Media Transfer Protocol monitor.
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-gphoto2-volume-monitor.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-gphoto2-volume-monitor.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Virtual filesystem service - digital camera monitor.
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-metadata.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-metadata.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Virtual filesystem metadata service.
Mär 11 16:00:44 GBi7 systemd[861]: dbus.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped D-Bus User Message Bus.
Mär 11 16:00:44 GBi7 systemd[861]: cloudsync.service: Main process exited, code=killed, status=15/TERM
Mär 11 16:00:44 GBi7 systemd[861]: cloudsync.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Cloud Storage Sync Daemon.
Mär 11 16:00:44 GBi7 systemd[861]: gvfs-daemon.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Virtual filesystem service.
Mär 11 16:00:44 GBi7 profile-sync-daemon[2229]: chromium resync successful
Mär 11 16:00:44 GBi7 systemd[861]: pulseaudio.service: Succeeded.
Mär 11 16:00:44 GBi7 systemd[861]: Stopped Sound Service.
Mär 11 16:00:45 GBi7 mkinitcpio[2198]: ==> Build complete.
Mär 11 16:00:45 GBi7 systemd[1]: mkinitcpio-generate-shutdown-ramfs.service: Succeeded.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Started Generate shutdown-ramfs.
Mär 11 16:00:45 GBi7 profile-sync-daemon[2229]: firefox resync successful
Mär 11 16:00:45 GBi7 profile-sync-daemon[2229]: chromium unsync successful
Mär 11 16:00:45 GBi7 profile-sync-daemon[2229]: firefox unsync successful
Mär 11 16:00:45 GBi7 systemd[861]: psd.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped Profile-sync-daemon.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped target Basic System.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped target Timers.
Mär 11 16:00:45 GBi7 systemd[861]: ebay.timer: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped Ebay Mail Timer.
Mär 11 16:00:45 GBi7 systemd[861]: psd-resync.timer: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped Timer for profile-sync-daemon - 1Hour.
Mär 11 16:00:45 GBi7 systemd[861]: countdown.timer: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped Countdown Mail Timer.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped target Paths.
Mär 11 16:00:45 GBi7 systemd[861]: Stopped target Sockets.
Mär 11 16:00:45 GBi7 systemd[861]: gpg-agent-browser.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Mär 11 16:00:45 GBi7 systemd[861]: pulseaudio.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed Sound System.
Mär 11 16:00:45 GBi7 systemd[861]: dbus.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed D-Bus User Message Bus Socket.
Mär 11 16:00:45 GBi7 systemd[861]: gpg-agent-extra.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Mär 11 16:00:45 GBi7 systemd[861]: dirmngr.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed GnuPG network certificate management daemon.
Mär 11 16:00:45 GBi7 systemd[861]: gpg-agent-ssh.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Mär 11 16:00:45 GBi7 systemd[861]: gpg-agent.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Closed GnuPG cryptographic agent and passphrase cache.
Mär 11 16:00:45 GBi7 systemd[861]: Reached target Shutdown.
Mär 11 16:00:45 GBi7 systemd[861]: systemd-exit.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[861]: Started Exit the Session.
Mär 11 16:00:45 GBi7 systemd[861]: Reached target Exit the Session.
Mär 11 16:00:45 GBi7 systemd[862]: pam_unix(systemd-user:session): session closed for user nrittsti
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: user@1000.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped User Manager for UID 1000.
Mär 11 16:00:45 GBi7 systemd[1]: Stopping User Runtime Directory /run/user/1000...
Mär 11 16:00:45 GBi7 systemd[1]: run-user-1000.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /run/user/1000.
Mär 11 16:00:45 GBi7 systemd[1]: user-runtime-dir@1000.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped User Runtime Directory /run/user/1000.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Removed slice User Slice of UID 1000.
Mär 11 16:00:45 GBi7 systemd[1]: systemd-logind.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Login Service.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: lightdm.service: Succeeded.
Mär 11 16:00:45 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=lightdm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Light Display Manager.
Mär 11 16:00:45 GBi7 systemd[1]: Stopping Permit User Sessions...
Mär 11 16:00:45 GBi7 systemd[1]: systemd-user-sessions.service: Succeeded.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Permit User Sessions.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target User and Group Name Lookups.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Network.
Mär 11 16:00:45 GBi7 systemd[1]: Stopping Network Manager...
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Remote File Systems.
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4417] caught SIGTERM, shutting down normally.
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4421] dhcp4 (enp0s31f6): canceled DHCP transaction
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4421] dhcp4 (enp0s31f6): state changed bound -> done
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4421] device (enp0s31f6): DHCPv4: 480 seconds grace period started
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4422] dhcp6 (enp0s31f6): canceled DHCP transaction
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4422] dhcp6 (enp0s31f6): state changed bound -> done
Mär 11 16:00:45 GBi7 NetworkManager[775]: <info>  [1552316445.4424] exiting (success)
Mär 11 16:00:45 GBi7 systemd[1]: NetworkManager.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Network Manager.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopping D-Bus System Message Bus...
Mär 11 16:00:45 GBi7 systemd[1]: dbus.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped D-Bus System Message Bus.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Basic System.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Slices.
Mär 11 16:00:45 GBi7 systemd[1]: Removed slice User and Session Slice.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Sockets.
Mär 11 16:00:45 GBi7 systemd[1]: snapd.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Closed Socket activation for snappy daemon.
Mär 11 16:00:45 GBi7 systemd[1]: org.cups.cupsd.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Closed CUPS Scheduler.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Paths.
Mär 11 16:00:45 GBi7 systemd[1]: org.cups.cupsd.path: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped CUPS Scheduler.
Mär 11 16:00:45 GBi7 systemd[1]: dbus.socket: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Closed D-Bus System Message Bus Socket.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target System Initialization.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: systemd-binfmt.service: Succeeded.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Set Up Additional Binary Formats.
Mär 11 16:00:45 GBi7 systemd[1]: Stopping Network Time Synchronization...
Mär 11 16:00:45 GBi7 systemd[1]: systemd-sysctl.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Apply Kernel Variables.
Mär 11 16:00:45 GBi7 systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Local Encrypted Volumes.
Mär 11 16:00:45 GBi7 systemd[1]: systemd-ask-password-wall.path: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Mär 11 16:00:45 GBi7 systemd[1]: systemd-ask-password-console.path: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Mär 11 16:00:45 GBi7 systemd[1]: Stopping Load/Save Random Seed...
Mär 11 16:00:45 GBi7 systemd[1]: systemd-modules-load.service: Succeeded.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Load Kernel Modules.
Mär 11 16:00:45 GBi7 systemd[1]: systemd-random-seed.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Load/Save Random Seed.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: systemd-timesyncd.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Network Time Synchronization.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 audit[2365]: SYSTEM_SHUTDOWN pid=2365 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:45 GBi7 systemd[1]: systemd-update-utmp.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: systemd-tmpfiles-setup.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Create Volatile Files and Directories.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Local File Systems.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting Mount unit for intellij-idea-community, revision 126...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /boot...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /tmp...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /home...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting Mount unit for pycharm-community, revision 117...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /mnt/archive...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting Mount unit for core, revision 6405...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /btrfs...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /var/cache/pacman/pkg...
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /.snapshots...
Mär 11 16:00:45 GBi7 systemd[1]: systemd-journal-flush.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Flush Journal to Persistent Storage.
Mär 11 16:00:45 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:45 GBi7 systemd[1]: Unmounting /var/log...
Mär 11 16:00:45 GBi7 umount[2379]: umount: /var/log: target is busy.
Mär 11 16:00:45 GBi7 systemd[1]: boot.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /boot.
Mär 11 16:00:45 GBi7 systemd[1]: btrfs.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /btrfs.
Mär 11 16:00:45 GBi7 systemd[1]: var-cache-pacman-pkg.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /var/cache/pacman/pkg.
Mär 11 16:00:45 GBi7 systemd[1]: \x2esnapshots.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /.snapshots.
Mär 11 16:00:45 GBi7 systemd[1]: var-log.mount: Mount process exited, code=exited, status=32/n/a
Mär 11 16:00:45 GBi7 systemd[1]: Failed unmounting /var/log.
Mär 11 16:00:45 GBi7 kernel: fbcon: Taking over console
Mär 11 16:00:45 GBi7 kernel: Console: switching to colour frame buffer device 240x67
Mär 11 16:00:45 GBi7 systemd[1]: tmp.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /tmp.
Mär 11 16:00:45 GBi7 systemd[1]: mnt-archive.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /mnt/archive.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Swap.
Mär 11 16:00:45 GBi7 systemd[1]: var-lib-snapd-snap-intellij\x2didea\x2dcommunity-126.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted Mount unit for intellij-idea-community, revision 126.
Mär 11 16:00:45 GBi7 systemd[1]: home.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted /home.
Mär 11 16:00:45 GBi7 systemd[1]: var-lib-snapd-snap-pycharm\x2dcommunity-117.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted Mount unit for pycharm-community, revision 117.
Mär 11 16:00:45 GBi7 systemd[1]: var-lib-snapd-snap-core-6405.mount: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Unmounted Mount unit for core, revision 6405.
Mär 11 16:00:45 GBi7 systemd[1]: Reached target Unmount All Filesystems.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped target Local File Systems (Pre).
Mär 11 16:00:45 GBi7 systemd[1]: Stopping Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
Mär 11 16:00:45 GBi7 systemd[1]: systemd-remount-fs.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Remount Root and Kernel File Systems.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: systemd-tmpfiles-setup-dev.service: Succeeded.
Mär 11 16:00:45 GBi7 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'
Mär 11 16:00:45 GBi7 systemd[1]: Stopped Create Static Device Nodes in /dev.
Mär 11 16:00:45 GBi7 systemd[1]: Reached target Shutdown.
Mär 11 16:00:45 GBi7 systemd[1]: Reached target Final Step.
Mär 11 16:00:45 GBi7 systemd[1]: systemd-poweroff.service: Succeeded.
Mär 11 16:00:45 GBi7 systemd[1]: Started Power-Off.
Mär 11 16:00:45 GBi7 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:45 GBi7 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mär 11 16:00:45 GBi7 systemd[1]: Reached target Power-Off.
Mär 11 16:00:45 GBi7 systemd[1]: Shutting down.
Mär 11 16:00:45 GBi7 kernel: printk: systemd-shutdow: 42 output lines suppressed due to ratelimiting
Mär 11 16:00:45 GBi7 systemd-shutdown[1]: Syncing filesystems and block devices.
Mär 11 16:00:45 GBi7 systemd-journald[380]: Journal stopped
-- Reboot --

No practical reasons, just curiosity, i can stay at 4.20.
My motivation is to understand the problem and learn something new.

1 Like

Isn’t this what a testing user is supposed to do? Test the new stuff and report potential issues so things get fixed over time? Genuine question…
At least that’s been my motivation to switch to testing, do my little bit to help moving things along…

Yes, not required but appreciated. I just wasnt sure this was the case here. When they stated they wanted to test/learn I liked it :wink:
[we have a not-just-sometimes thing of casual users upgrading kernel like popping candy and then complaining about 5.1-rc not working]

Ill also add … testing or unstable can also be personal choices - maybe you like more constant, smaller, updates instead of big ones every few weeks. Maybe you want to be more bleeding edge or closer to Arch. etc. The branches dont come with responsibilities to the distro - but they do allow you to act like a sort of vanguard for stable or give back in other ways, if you choose to.

1 Like

Whilst i acknowledge all the sane voices above cautioning against early-adopter perils, i’d like to confirm that 5.x, but i suspect specifically 5.0.1-1 rather than 5.0.0, also sticks for ~2’ during SD/reboot… but not at the same place as the OP. For me, it occurs at Started TLP system startup/shutdown.

Using 4.20.x, that message just whizzes by, & the entire SD/reboot process exhibits satisfactory alacrity :roll_eyes: ahem it’s fast enough for me :grin:

This morning i discovered an additional bug with 5.0.1-1… after Resume from Suspend, there is no sound output. :cry: Running systemctl restart --user pulseaudio.service does not help, logging out/in does not help, logging out of Plasma & into GNOME does not help, only a reboot gives my sound back. This bug afair did not occur with 5.0.0, & certainly it does not occur with 4.20.x, thus i’ve had to boot back into 4.20.15, with which i’ll continue til a later 5.x arrives.

1 Like

Try this…worked for me in the early 5.0-rc builds:

2 Likes

More brilliant wizardry from you – it works for me! Many thanks.

1 Like

Hello oh wise one. This morning the magic has gone away… sob, sniff, bwahhhhh.

Resumed Tower as usual from its nightly slumbers, to be greeted with … no sound. I’ve inspected my /etc/pulse/default.pa & confirmed that my previous edit remains intact, ie, that line remains commented-out. I issued [several times] the command systemctl restart --user pulseaudio.service, but that did not help. Looking at the SystemTray volume widget, its analogue volume control is missing. Looking in pavucontrol reveals this ridiculous status:

My mind is foggy atm; i can’t remember if today is the first or second Tower Resume since i applied the latest Testing Update, which took kernel from 5.0.1-x to 5.0.2-2 … has this new kernel bump broken your fix? I shall keep working as-is for now rather than reboot, in case you might happen along & have some amended inspiration for this silly situation pls.

Aha, from sudo journalctl --list-boots i see …

 -1 7269c3c77d0e4967874d543fdbaa9335 Sun 2019-03-17 23:53:01 AEDT—Mon 2019-03-18 00:18:10 AEDT
  0 0e660a3cbf804781a24a8d04b37b4621 Mon 2019-03-18 00:20:07 AEDT—Wed 2019-03-20 11:08:52 AEDT

… so this is the 2nd not 1st Resume, ie, kernel cannot be the root cause otherwise sound should have failed with yesterday’s morning’s Resume, not today’s. Sigh.


Edit, laterShassen rassen frassen… Pamac pulled a swifty on me, grrrr. Told me there was one [1] update available, Vivaldi-Snapshot, so i accepted it. Damn thing then snuck in a Pamac package update, & updated all my kernels, as well as doing V. Had other stuff to do, didn’t expect this, would not have done the update atm had i known kernels were included… tried to then get on with doing my other stuff [post-Pamac], but my resident Tower Poltergeist did not like that so it froze everything, forcing a damn inconvenient reboot. So now i’m back up & running the new kernel 5.0.3-1. Wonder what will happen with tomorrow morn’s Resume re audio.

Well, well, an ongoing cornucopia of “surprises”. This morning’s Resume greeted me with… working audio, yay… but no blooody network, gahhhhh. 5.0.x is proving to be “exciting”. :dizzy_face:

Since I’ve moved to i3, the only ‘problem’ that I have with audio is that the headphones are muted after every reboot. Not too big an issue, as headphones aren’t really compatible with my hearing aids. :grin:

Sorry to hear about your ongoing issues. :frowning:

Jawohl, i saw wot you did there. :upside_down_face:

1 Like

What did he SAY ?

I cant HEAR U :smile:
Please Repeat that :smile:

Peace

https://cdn.kernel.org/pub/linux/kernel/v5.x/ChangeLog-5.0.4
check this future change
nfit: Fix nfit_intel_shutdown_status() command submission

2 Likes

What a shame, my situation has not changed with Kernel 5.0.4 :worried:
… the commit looked so promising.
Time flies … 4.20 has reached EOL, so it is time for switching back to 4.19.

Hey @kdemeoz how is your problem Tower now, is improvement in sight?

1 Like

have you change branch in Testing to check ?

Look here, in this other topic: I tested also 5.0.4 from the Testing branch and I have the same behavior: first shutdown takes 90s, but then further shutdowns are OK… at least for me.

Howdy. 5.0.x has been low-friction good on my Lappy, but has given my Tower a bumpy inconsistent ride.

  1. Initially it caused audio to fail after Suspend-Resume - @merlock’s magic seemed to fix that at first, but once subsequent dot-updates arrived, each morning’s post-Resume audio availability was a pure lucky dip – sometimes good, sometimes gone [& when it had gone, nothing but a reboot helped].
  2. One morning post-Resume it still had audio, but coz variety is the spice of life it instead gave me no network. Grrr.
  3. I never experienced the miraculous self-learning >3rd reboot ending of those ~2’ SD lags, ie, i still had them every time.
  4. Furthermore, each SD or reboot resulted in a litany of DMESG messages of a very strange nature, quite different to what i’d been used to seeing with older kernels. Many of these entries look nasty, like there were many problems.
  5. Fwiw, 5.0 is also bad in all my Manjaro VMs, wrt Shared Folders. They’re all broken when i run 5.0 in each VM, but once i reboot them into 4.19 [& 4.20 until i removed it t’other day] my SFs are good again.

Yesterday morn’s Resume again gave me no audio, so for me that was the straw that broke the camel’s back… given i then had to reboot anyway [btw, it did do another ~2’ lag then] to recover the audio, i booted into 4.19 not 5. I’ve decided to abandon the rest of the 5.0 series, & will try 5.1 when it’s available.

This morning’s Resume [with 4.19] was hassle-free. Lovely. 5.0 is not a happy camper, for my Tower anyway.

2 Likes

new version kernels
https://cdn.kernel.org/pub/linux/kernel/v5.x/ChangeLog-5.0.5

still investigation

Author: Waiman Long longman@redhat.com
Date: Wed Jan 9 23:03:25 2019 -0500

locking/lockdep: Add debug_locks check in __lock_downgrade()
1 Like

Yup, i’m riding on the testing branch.
That’s not a big deal, just only a few miles from testing to stable.

That sounds curious … no matter, solved is solved.
My system did not surprise me with self-healing capabilities after a couple of reboots.

Woa, I see … ugly issues.
Still has a long, long way to go until we can tag that thing as stable.
It can only get better!