Shutdown causes power light to blink after failed suspend (Fedora 37)

ashleigh · November 28, 2022, 9:34pm

Updated to Fedora 37 yesterday. Running kernel 6.0.9-300.fc37.x86_64

I have shutdown successfully on Sunday and again today. Then I tried to suspend (which has worked without issue prior to the upgrade) and the PC entered a loop with the fans spinning down and back up repeatedly, but the screen remaining blank and never seemingly reaching post or suspending properly. After a few cycles I held the power for a hard shutdown.

Now when I shutdown (with UI or with shutdown now or systemctl poweroff), the PC appears to shut down but the power light remains blinking, as if it’s in hibernate. Pressing the power button again boots as normal, including bios and grub screens so I don’t think it’s actually hibernating. To properly shutdown (or at least stop the blinking light) I have to turn off power at the wall.

Here is the output of journalctl -b -1 | tail -500

Nov 28 21:08:28 fedora systemd[1]: Stopped nordvpnd.service - NordVPN Daemon.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=nordvpnd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Received SIGRTMIN+20 from PID 2130 (plymouthd).
Nov 28 21:08:28 fedora systemd[1]: Stopped target network-online.target - Network is Online.
Nov 28 21:08:28 fedora systemd[1]: NetworkManager-wait-online.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped NetworkManager-wait-online.service - Network Manager Wait Online.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopping livesys.service - LSB: Init script for live image....
Nov 28 21:08:28 fedora systemd[1]: Stopping uresourced.service - User resource assignment daemon...
Nov 28 21:08:28 fedora uresourced[1575]: Setting resources on user-42.slice (MemoryMin: 0, MemoryLow: 0, CPUWeight: 100, IOWeight: 100)
Nov 28 21:08:28 fedora uresourced[1575]: Setting resources on user@42.service (MemoryMin: 0, MemoryLow: 0, CPUWeight: 100, IOWeight: 100)
Nov 28 21:08:28 fedora uresourced[1575]: Setting resources on user.slice (MemoryMin: 0, MemoryLow: 0, CPUWeight: -, IOWeight: -)
Nov 28 21:08:28 fedora systemd[1]: Stopping user-runtime-dir@42.service - User Runtime Directory /run/user/42...
Nov 28 21:08:28 fedora systemd[1]: run-user-42.mount: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Unmounted run-user-42.mount - /run/user/42.
Nov 28 21:08:28 fedora systemd[1]: systemd-logind.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-logind.service - User Login Management.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-logind comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Started plymouth-poweroff.service - Show Plymouth Power Off Screen.
Nov 28 21:08:28 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=plymouth-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: livesys.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped livesys.service - LSB: Init script for live image..
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=livesys comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: user-runtime-dir@42.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped user-runtime-dir@42.service - User Runtime Directory /run/user/42.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=user-runtime-dir@42 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora systemd[1]: Removed slice user-42.slice - User Slice of UID 42.
Nov 28 21:08:28 fedora systemd[1]: user-42.slice: Consumed 2.846s CPU time.
Nov 28 21:08:28 fedora systemd[1]: plymouth-switch-root-initramfs.service - Tell Plymouth To Jump To initramfs was skipped because of a failed condition check (ConditionPathExists=/run/initramfs/bin/sh).
Nov 28 21:08:28 fedora systemd[1]: Stopping systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer...
Nov 28 21:08:28 fedora systemd[1]: Stopping systemd-user-sessions.service - Permit User Sessions...
Nov 28 21:08:28 fedora systemd[1]: systemd-oomd.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: uresourced.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped uresourced.service - User resource assignment daemon.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=uresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: systemd-user-sessions.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-user-sessions.service - Permit User Sessions.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-user-sessions comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped target nss-user-lookup.target - User and Group Name Lookups.
Nov 28 21:08:28 fedora systemd[1]: Stopped target remote-fs.target - Remote File Systems.
Nov 28 21:08:28 fedora systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
Nov 28 21:08:28 fedora systemd[1]: Stopped target nfs-client.target - NFS client services.
Nov 28 21:08:28 fedora systemd[1]: Stopping gssproxy.service - GSSAPI Proxy Daemon...
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora systemd[1]: gssproxy.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped gssproxy.service - GSSAPI Proxy Daemon.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=gssproxy comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped target network.target - Network.
Nov 28 21:08:28 fedora systemd[1]: Stopping NetworkManager.service - Network Manager...
Nov 28 21:08:28 fedora NetworkManager[1304]: <info [1669669708.3746] caught SIGTERM, shutting down normally.
Nov 28 21:08:28 fedora systemd[1]: Stopping wpa_supplicant.service - WPA supplicant...
Nov 28 21:08:28 fedora systemd[1]: wpa_supplicant.service: Deactivated successfully.
Nov 28 21:08:28 fedora NetworkManager[1304]: <info [1669669708.3810] dhcp4 (enp5s0): canceled DHCP transaction
Nov 28 21:08:28 fedora NetworkManager[1304]: <info [1669669708.3810] dhcp4 (enp5s0): activation: beginning transaction (timeout in 45 seconds)
Nov 28 21:08:28 fedora NetworkManager[1304]: <info [1669669708.3810] dhcp4 (enp5s0): state changed no lease
Nov 28 21:08:28 fedora NetworkManager[1304]: <info [1669669708.3812] manager: NetworkManager state is now CONNECTED_SITE
Nov 28 21:08:28 fedora systemd[1]: Stopped wpa_supplicant.service - WPA supplicant.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=wpa_supplicant comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Requested transaction contradicts existing jobs: Transaction for NetworkManager-dispatcher.service/start is destructive (shutdown.target has 'start' job queued, but 'stop' is included in transaction).
Nov 28 21:08:28 fedora NetworkManager[1304]: <info [1669669708.3960] exiting (success)
Nov 28 21:08:28 fedora systemd[1]: NetworkManager.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped NetworkManager.service - Network Manager.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped target network-pre.target - Preparation for Network.
Nov 28 21:08:28 fedora systemd[1]: Stopping firewalld.service - firewalld - dynamic firewall daemon...
Nov 28 21:08:28 fedora systemd[1]: systemd-network-generator.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora audit[1245]: NETFILTER_CFG table=firewalld:5 family=1 entries=376 op=nft_unregister_obj pid=1245 subj=system_u:system_r:firewalld_t:s0 comm="firewalld"
Nov 28 21:08:28 fedora audit[1245]: NETFILTER_CFG table=firewalld:5 family=1 entries=181 op=nft_unregister_table pid=1245 subj=system_u:system_r:firewalld_t:s0 comm="firewalld"
Nov 28 21:08:28 fedora systemd[1]: firewalld.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped firewalld.service - firewalld - dynamic firewall daemon.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=firewalld comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopping polkit.service - Authorization Manager...
Nov 28 21:08:28 fedora systemd[1]: polkit.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped polkit.service - Authorization Manager.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=polkit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped target basic.target - Basic System.
Nov 28 21:08:28 fedora systemd[1]: systemd-ask-password-plymouth.path: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch.
Nov 28 21:08:28 fedora systemd[1]: Stopped target paths.target - Path Units.
Nov 28 21:08:28 fedora systemd[1]: cups.path: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped cups.path - CUPS Scheduler.
Nov 28 21:08:28 fedora systemd[1]: Stopped target slices.target - Slice Units.
Nov 28 21:08:28 fedora systemd[1]: Removed slice machine.slice - Virtual Machine and Container Slice.
Nov 28 21:08:28 fedora systemd[1]: Removed slice user.slice - User and Session Slice.
Nov 28 21:08:28 fedora systemd[1]: user.slice: Consumed 2.846s CPU time.
Nov 28 21:08:28 fedora systemd[1]: Stopped target sockets.target - Socket Units.
Nov 28 21:08:28 fedora systemd[1]: avahi-daemon.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket.
Nov 28 21:08:28 fedora systemd[1]: cups.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed cups.socket - CUPS Scheduler.
Nov 28 21:08:28 fedora systemd[1]: iscsid.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
Nov 28 21:08:28 fedora systemd[1]: iscsiuio.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Nov 28 21:08:28 fedora systemd[1]: nordvpnd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed nordvpnd.socket - NordVPN Daemon Socket.
Nov 28 21:08:28 fedora systemd[1]: pcscd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed pcscd.socket - PC/SC Smart Card Daemon Activation Socket.
Nov 28 21:08:28 fedora systemd[1]: sssd-kcm.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed sssd-kcm.socket - SSSD Kerberos Cache Manager responder socket.
Nov 28 21:08:28 fedora systemd[1]: virtinterfaced.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtinterfaced.socket - Libvirt interface local socket.
Nov 28 21:08:28 fedora systemd[1]: virtlockd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtlockd.socket - Virtual machine lock manager socket.
Nov 28 21:08:28 fedora systemd[1]: virtlogd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtlogd.socket - Virtual machine log manager socket.
Nov 28 21:08:28 fedora systemd[1]: virtlxcd-admin.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtlxcd-admin.socket - Libvirt lxc admin socket.
Nov 28 21:08:28 fedora systemd[1]: virtlxcd-ro.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtlxcd-ro.socket - Libvirt lxc local read-only socket.
Nov 28 21:08:28 fedora systemd[1]: virtlxcd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtlxcd.socket - Libvirt lxc local socket.
Nov 28 21:08:28 fedora systemd[1]: virtnetworkd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtnetworkd.socket - Libvirt network local socket.
Nov 28 21:08:28 fedora systemd[1]: virtnodedevd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtnodedevd.socket - Libvirt nodedev local socket.
Nov 28 21:08:28 fedora systemd[1]: virtnwfilterd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtnwfilterd.socket - Libvirt nwfilter local socket.
Nov 28 21:08:28 fedora systemd[1]: virtproxyd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtproxyd.socket - Libvirt proxy local socket.
Nov 28 21:08:28 fedora systemd[1]: virtqemud-admin.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtqemud-admin.socket - Libvirt qemu admin socket.
Nov 28 21:08:28 fedora systemd[1]: virtqemud-ro.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtqemud-ro.socket - Libvirt qemu local read-only socket.
Nov 28 21:08:28 fedora systemd[1]: virtqemud.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtqemud.socket - Libvirt qemu local socket.
Nov 28 21:08:28 fedora systemd[1]: virtsecretd.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtsecretd.socket - Libvirt secret local socket.
Nov 28 21:08:28 fedora systemd[1]: virtstoraged.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed virtstoraged.socket - Libvirt storage local socket.
Nov 28 21:08:28 fedora dbus-broker[1011]: Dispatched 5143 messages @ 5(±13)μs / message.
Nov 28 21:08:28 fedora systemd[1]: Stopping dbus-broker.service - D-Bus System Message Bus...
Nov 28 21:08:28 fedora systemd[1]: dbus-broker.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped dbus-broker.service - D-Bus System Message Bus.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=dbus-broker comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: dbus.socket: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Closed dbus.socket - D-Bus System Message Bus Socket.
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora systemd[1]: Stopped target sysinit.target - System Initialization.
Nov 28 21:08:28 fedora systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Unset automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
Nov 28 21:08:28 fedora systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
Nov 28 21:08:28 fedora systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
Nov 28 21:08:28 fedora systemd[1]: Stopped target integritysetup.target - Local Integrity Protected Volumes.
Nov 28 21:08:28 fedora systemd[1]: Stopped target veritysetup.target - Local Verity Protected Volumes.
Nov 28 21:08:28 fedora systemd[1]: systemd-boot-update.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-boot-update.service - Automatic Boot Loader Update.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
Nov 28 21:08:28 fedora systemd[1]: systemd-sysctl.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: systemd-modules-load.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopping systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
Nov 28 21:08:28 fedora systemd[1]: systemd-resolved.service: Deactivated successfully.
Nov 28 21:08:28 fedora audit[2161]: SYSTEM_SHUTDOWN pid=2161 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: systemd-update-utmp.service: Deactivated successfully.
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopping auditd.service - Security Auditing Service...
Nov 28 21:08:28 fedora auditd[980]: The audit daemon is exiting.
Nov 28 21:08:28 fedora kernel: audit: type=1305 audit(1669669708.779:337): op=set audit_pid=0 old=980 auid=4294967295 ses=4294967295 subj=system_u:system_r:auditd_t:s0 res=1
Nov 28 21:08:28 fedora audit: CONFIG_CHANGE op=set audit_pid=0 old=980 auid=4294967295 ses=4294967295 subj=system_u:system_r:auditd_t:s0 res=1
Nov 28 21:08:28 fedora systemd[1]: auditd.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped auditd.service - Security Auditing Service.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=auditd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.788:338): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=auditd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: import-state.service: Deactivated successfully.
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.797:339): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped import-state.service - Import network configuration from initramfs.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=import-state comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped target local-fs.target - Local File Systems.
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.806:340): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=import-state comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Unmounting boot-efi.mount - /boot/efi...
Nov 28 21:08:28 fedora systemd[1]: Unmounting home.mount - /home...
Nov 28 21:08:28 fedora systemd[1]: Unmounting tmp.mount - Temporary Directory /tmp...
Nov 28 21:08:28 fedora systemd[1]: boot-efi.mount: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Unmounted boot-efi.mount - /boot/efi.
Nov 28 21:08:28 fedora systemd[1]: home.mount: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Unmounted home.mount - /home.
Nov 28 21:08:28 fedora systemd[1]: tmp.mount: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Unmounted tmp.mount - Temporary Directory /tmp.
Nov 28 21:08:28 fedora systemd[1]: Stopped target swap.target - Swaps.
Nov 28 21:08:28 fedora systemd[1]: Deactivating swap dev-zram0.swap - Compressed Swap on /dev/zram0...
Nov 28 21:08:28 fedora systemd[1]: Unmounting boot.mount - /boot...
Nov 28 21:08:28 fedora systemd[1]: systemd-fsck@dev-disk-by\x2duuid-D5FA\x2d573A.service: Deactivated successfully.
Nov 28 21:08:28 fedora kernel: EXT4-fs (nvme0n1p2): unmounting filesystem.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-fsck@dev-disk-by\x2duuid-D5FA\x2d573A.service - File System Check on /dev/disk/by-uuid/D5FA-573A.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2duuid-D5FA\x2d573A comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.870:341): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2duuid-D5FA\x2d573A comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: dev-zram0.swap: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Deactivated swap dev-zram0.swap - Compressed Swap on /dev/zram0.
Nov 28 21:08:28 fedora systemd[1]: boot.mount: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Unmounted boot.mount - /boot.
Nov 28 21:08:28 fedora systemd[1]: Reached target umount.target - Unmount All Filesystems.
Nov 28 21:08:28 fedora systemd[1]: systemd-fsck@dev-disk-by\x2duuid-72fa5b74\x2dbc2a\x2d4b81\x2db253\x2d1d87edc988d4.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-fsck@dev-disk-by\x2duuid-72fa5b74\x2dbc2a\x2d4b81\x2db253\x2d1d87edc988d4.service - File System Check on /dev/disk/by-uuid/72fa5b74-bc2a-4b81-b253-1d87edc988d4.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2duuid-72fa5b74\x2dbc2a\x2d4b81\x2db253\x2d1d87edc988d4 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.898:342): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2duuid-72fa5b74\x2dbc2a\x2d4b81\x2db253\x2d1d87edc988d4 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Removed slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
Nov 28 21:08:28 fedora systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems.
Nov 28 21:08:28 fedora systemd[1]: Stopping lvm2-monitor.service - Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
Nov 28 21:08:28 fedora systemd[1]: systemd-remount-fs.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-remount-fs.service - Remount Root and Kernel File Systems.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.922:343): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.931:344): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopping systemd-zram-setup@zram0.service - Create swap on /dev/zram0...
Nov 28 21:08:28 fedora kernel: zram0: detected capacity change from 16777216 to 0
Nov 28 21:08:28 fedora systemd[1]: systemd-zram-setup@zram0.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Stopped systemd-zram-setup@zram0.service - Create swap on /dev/zram0.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-zram-setup@zram0 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: lvm2-monitor.service: Deactivated successfully.
Nov 28 21:08:28 fedora kernel: audit: type=1131 audit(1669669708.959:345): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-zram-setup@zram0 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Stopped lvm2-monitor.service - Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=lvm2-monitor comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Removed slice system-systemd\x2dzram\x2dsetup.slice - Slice /system/systemd-zram-setup.
Nov 28 21:08:28 fedora systemd[1]: Reached target shutdown.target - System Shutdown.
Nov 28 21:08:28 fedora systemd[1]: Reached target final.target - Late Shutdown Services.
Nov 28 21:08:28 fedora systemd[1]: systemd-poweroff.service: Deactivated successfully.
Nov 28 21:08:28 fedora systemd[1]: Finished systemd-poweroff.service - System Power Off.
Nov 28 21:08:28 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov 28 21:08:28 fedora systemd[1]: Reached target poweroff.target - System Power Off.
Nov 28 21:08:28 fedora systemd[1]: Shutting down.
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:28 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora audit: BPF prog-id=0 op=UNLOAD
Nov 28 21:08:29 fedora systemd-shutdown[1]: Syncing filesystems and block devices.
Nov 28 21:08:29 fedora systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Nov 28 21:08:29 fedora systemd-journald[773]: Journal stopped

I’m not sure what I should be looking for but it seems to be powering off successfully. Has anyone got any tips on where I should look? I have googled a lot but no luck so far. I’m assuming it’s something to do with that failed suspend earlier in the day, but I don’t know how to check or how to clear out any corrupted/left behind cache that’s causing it to think it’s hibernating.

Thanks

Ash

vwbusguy · November 28, 2022, 11:49pm

How are you shutting it down? The halt command would cause the operating system to shut down, but not actually power off, for example.

picopress · November 29, 2022, 3:58am

If the firmware isn’t latest version, you have to update it. Also I think that the more journal logs can be needed, for instance sudo journalctl -b -1 | tail 1000

ashleigh · November 29, 2022, 8:56pm

I am shutting down with the top right Power button, then selecting power off and confirming at the prompt. I also tried shutdown now in terminal and systemctl poweroff. All cause the same blinking light.

I’ll update this message with a longer log in a little bit (can’t restart just now). Thanks for taking a look.

UPDATE : Ok here is the last 1000 lines : Nov 29 21:18:38 fedora gnome-shell[2288]: g_signal_handler_disconnect: assertion - Pastebin.com

The shutdown command happens at line 323. The errors before this I don’t think are relevant, I was editing a video in shotcut and then uploading but noticed no unusual behaviour during this.

ashleigh · November 30, 2022, 5:31pm

Well my PSU just blew up. I suppose it’s very unlikely to be a Fedora issue now

I just switched on the machine, finished a dnf update and there was an extremely loud pop and a burning smell coming from the PSU so something has blown, hopefully it’s contained and didn’t fry anything else. Wont know for a few days. I hadn’t realised how old this PSU was, it released in 2006! I guess this outcome was only a matter of time.

vwbusguy · November 30, 2022, 5:34pm

Ah yeah, that can certainly do it. Glad it didn’t cause a bigger fire! When the smoke clears, you’re going to want to test out the rest of the components to make sure they survived (SMART, memtest, etc.), if the board boots that is.

computersavvy · November 30, 2022, 5:39pm

That PSU failure may have been the problem all along.