You are not logged in.
Pages: 1
Hi,
I just got a new machine built and installed arch. Every time I suspend and hibernate (via "systemctl suspend"/"systemctl hibernate") my screen turns off, back on, then off again but my computer's fans and lights are all still on. I do have some suspicious messages in journalctl, but googling them didn't result in anything. Any help is appreciated!
Things I've tried:
Using linux-lts
Updating bios to latest firmware
Disabling all devices in /proc/acpi/wakeup
Unplugging every USB device to debug suspend
Some info:
Ryzen 3800X
X570 Taichi
amd_iommu=on is passed as a kernel parameter during boot
"sudo journalctl -b":
Jan 06 18:17:41 blarch polkitd[627]: Registered Authentication Agent for unix-process:1999:112106 (system bus name :1.176 [/usr/bin/pkttyagent --notify-fd 5 --fallback], object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale e>
Jan 06 18:17:41 blarch NetworkManager[544]: <info> [1578363461.2061] manager: sleep: sleep requested (sleeping: no enabled: yes)
Jan 06 18:17:41 blarch NetworkManager[544]: <info> [1578363461.2061] manager: NetworkManager state is now ASLEEP
Jan 06 18:17:41 blarch polkitd[627]: Unregistered Authentication Agent for unix-process:1999:112106 (system bus name :1.176, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale en_US.UTF-8) (disconnected from bus)
Jan 06 18:17:41 blarch systemd[1]: Reached target Sleep.
Jan 06 18:17:41 blarch systemd[1]: Starting Suspend...
Jan 06 18:17:41 blarch systemd-sleep[2004]: Suspending system...
Jan 06 18:17:41 blarch kernel: PM: suspend entry (deep)
Jan 06 18:17:43 blarch kernel: PM: Syncing filesystems ... done.
Jan 06 18:17:43 blarch kernel: Freezing user space processes ... (elapsed 0.001 seconds) done.
Jan 06 18:17:43 blarch kernel: OOM killer disabled.
Jan 06 18:17:43 blarch kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Jan 06 18:17:43 blarch kernel: Suspending console(s) (use no_console_suspend to debug)
Jan 06 18:17:43 blarch kernel: sd 2:0:0:0: [sdb] Synchronizing SCSI cache
Jan 06 18:17:43 blarch kernel: sd 2:0:0:0: [sdb] Stopping disk
Jan 06 18:17:43 blarch kernel: sd 1:0:0:0: [sda] Synchronizing SCSI cache
Jan 06 18:17:43 blarch kernel: sd 1:0:0:0: [sda] Stopping disk
Jan 06 18:17:43 blarch kernel: ata1: failed stop FIS RX (-16)
Jan 06 18:17:43 blarch kernel: ata1: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:43 blarch kernel: PM: noirq suspend of devices failed
Jan 06 18:17:43 blarch kernel: sd 1:0:0:0: [sda] Starting disk
Jan 06 18:17:43 blarch kernel: sd 2:0:0:0: [sdb] Starting disk
Jan 06 18:17:43 blarch kernel: [drm] PCIE GART of 256M enabled (table at 0x000000F400000000).
Jan 06 18:17:43 blarch kernel: amdgpu: [powerplay] dpm has been enabled
Jan 06 18:17:43 blarch kernel: nvme nvme0: Shutdown timeout set to 10 seconds
Jan 06 18:17:43 blarch kernel: ata4: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:43 blarch kernel: ata5: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:43 blarch kernel: ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jan 06 18:17:43 blarch kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jan 06 18:17:43 blarch kernel: ata2.00: NCQ Send/Recv Log not supported
Jan 06 18:17:43 blarch kernel: ata2.00: NCQ Send/Recv Log not supported
Jan 06 18:17:43 blarch kernel: ata2.00: configured for UDMA/133
Jan 06 18:17:43 blarch kernel: ata2.00: Enabling discard_zeroes_data
Jan 06 18:17:43 blarch kernel: ata3.00: supports DRM functions and may not be fully accessible
Jan 06 18:17:43 blarch kernel: ata3.00: NCQ Send/Recv Log not supported
Jan 06 18:17:43 blarch kernel: ata3.00: supports DRM functions and may not be fully accessible
Jan 06 18:17:43 blarch kernel: ata3.00: NCQ Send/Recv Log not supported
Jan 06 18:17:43 blarch kernel: ata3.00: configured for UDMA/133
Jan 06 18:17:43 blarch kernel: [drm] UVD and UVD ENC initialized successfully.
Jan 06 18:17:43 blarch kernel: [drm] VCE initialized successfully.
Jan 06 18:17:43 blarch kernel: nvme nvme0: ctrl returned bogus length: 16 for NVME_NIDT_EUI64
Jan 06 18:17:43 blarch kernel: ahci 0000:0c:00.0: failed stop FIS RX (-16)
Jan 06 18:17:43 blarch kernel: ------------[ cut here ]------------
Jan 06 18:17:43 blarch kernel: WARNING: CPU: 14 PID: 257 at drivers/ata/libata-eh.c:4167 ata_scsi_port_error_handler.cold+0x36/0x3d [libata]
Jan 06 18:17:43 blarch kernel: Modules linked in: fuse devlink xt_CHECKSUM ipt_MASQUERADE xt_conntrack ipt_REJECT xt_tcpudp nf_nat_tftp nf_conntrack_tftp nft_objref tun nf_conntrack_netbios_ns nf_conntrack_broadcast nft_fib_inet nft_fib_ip>
Jan 06 18:17:43 blarch kernel: chash snd_hda_codec_generic gpu_sched wmi_bmof crct10dif_pclmul crc32_pclmul ghash_clmulni_intel mxm_wmi ttm btusb snd_hda_codec_hdmi pcbc btrtl btbcm drm_kms_helper btintel snd_hda_intel bluetooth snd_hda_c>
Jan 06 18:17:43 blarch kernel: vfio
Jan 06 18:17:43 blarch kernel: CPU: 14 PID: 257 Comm: scsi_eh_0 Not tainted 4.19.92-1-lts #1
Jan 06 18:17:43 blarch kernel: Hardware name: To Be Filled By O.E.M. To Be Filled By O.E.M./X570 Taichi, BIOS P2.70 11/25/2019
Jan 06 18:17:43 blarch kernel: RIP: 0010:ata_scsi_port_error_handler.cold+0x36/0x3d [libata]
Jan 06 18:17:43 blarch kernel: Code: 0f 0b e9 ab 65 ff ff 48 c7 c7 90 c0 58 c0 e8 81 4d 16 e7 0f 0b 48 8b 4b 08 e9 1b 69 ff ff 48 c7 c7 90 c0 58 c0 e8 6a 4d 16 e7 <0f> 0b e9 76 62 ff ff 48 c7 c7 90 c0 58 c0 e8 57 4d 16 e7 0f 0b e9
Jan 06 18:17:43 blarch kernel: RSP: 0018:ffffad2b43cebe28 EFLAGS: 00010246
Jan 06 18:17:43 blarch kernel: RAX: 0000000000000024 RBX: ffff9489d6e5c000 RCX: 0000000000000000
Jan 06 18:17:43 blarch kernel: RDX: 0000000000000000 RSI: ffff9489de9965b8 RDI: ffff9489de9965b8
Jan 06 18:17:43 blarch kernel: RBP: ffff9489daa83000 R08: ffff9489de9965b8 R09: ffff9489ff32d0c0
Jan 06 18:17:43 blarch kernel: R10: 00000000000005fe R11: 000000000001e3f0 R12: ffff9489d6e5c000
Jan 06 18:17:43 blarch kernel: R13: ffffad2b43cbb8d0 R14: ffff9489d6e5e040 R15: ffff9489d68c1dc0
Jan 06 18:17:43 blarch kernel: FS: 0000000000000000(0000) GS:ffff9489de980000(0000) knlGS:0000000000000000
Jan 06 18:17:43 blarch kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jan 06 18:17:43 blarch kernel: CR2: 00005623db333498 CR3: 00000007db728000 CR4: 0000000000340ee0
Jan 06 18:17:43 blarch kernel: Call Trace:
Jan 06 18:17:43 blarch kernel: ata_scsi_error+0x91/0xc0 [libata]
Jan 06 18:17:43 blarch kernel: scsi_error_handler+0xbf/0x5d0 [scsi_mod]
Jan 06 18:17:43 blarch kernel: kthread+0xfb/0x130
Jan 06 18:17:43 blarch kernel: ? scsi_eh_get_sense+0x1f0/0x1f0 [scsi_mod]
Jan 06 18:17:43 blarch kernel: ? kthread_park+0x80/0x80
Jan 06 18:17:43 blarch kernel: ret_from_fork+0x22/0x40
Jan 06 18:17:43 blarch kernel: ---[ end trace 2057f1aba5903031 ]---
Jan 06 18:17:43 blarch kernel: ata1: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:43 blarch kernel: OOM killer enabled.
Jan 06 18:17:43 blarch kernel: Restarting tasks ... done.
Jan 06 18:17:43 blarch kernel: PM: suspend exit
Jan 06 18:17:43 blarch kernel: PM: suspend entry (s2idle)
Jan 06 18:17:43 blarch pulseaudio[1012]: W: [alsa-sink-USB Audio] alsa-util.c: Could not recover alsa device from SUSPENDED state, trying to restart PCM
Jan 06 18:17:50 blarch kernel: PM: Syncing filesystems ... done.
Jan 06 18:17:50 blarch kernel: Freezing user space processes ... (elapsed 0.001 seconds) done.
Jan 06 18:17:50 blarch kernel: OOM killer disabled.
Jan 06 18:17:50 blarch kernel: Freezing remaining freezable tasks ... (elapsed 0.083 seconds) done.
Jan 06 18:17:50 blarch kernel: Suspending console(s) (use no_console_suspend to debug)
Jan 06 18:17:50 blarch kernel: sd 1:0:0:0: [sda] Synchronizing SCSI cache
Jan 06 18:17:50 blarch kernel: sd 2:0:0:0: [sdb] Synchronizing SCSI cache
Jan 06 18:17:50 blarch kernel: sd 1:0:0:0: [sda] Stopping disk
Jan 06 18:17:50 blarch kernel: sd 2:0:0:0: [sdb] Stopping disk
Jan 06 18:17:50 blarch kernel: ata1: failed stop FIS RX (-16)
Jan 06 18:17:50 blarch kernel: ata1: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:50 blarch kernel: sd 2:0:0:0: [sdb] Starting disk
Jan 06 18:17:50 blarch kernel: sd 1:0:0:0: [sda] Starting disk
Jan 06 18:17:50 blarch kernel: [drm] PCIE GART of 256M enabled (table at 0x000000F400000000).
Jan 06 18:17:50 blarch kernel: amdgpu: [powerplay] dpm has been enabled
Jan 06 18:17:50 blarch kernel: ata5: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:50 blarch kernel: ata4: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:50 blarch kernel: ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jan 06 18:17:50 blarch kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jan 06 18:17:50 blarch kernel: ata2.00: NCQ Send/Recv Log not supported
Jan 06 18:17:50 blarch kernel: ata2.00: NCQ Send/Recv Log not supported
Jan 06 18:17:50 blarch kernel: ata2.00: configured for UDMA/133
Jan 06 18:17:50 blarch kernel: ata2.00: Enabling discard_zeroes_data
Jan 06 18:17:50 blarch kernel: ata3.00: supports DRM functions and may not be fully accessible
Jan 06 18:17:50 blarch kernel: ata3.00: NCQ Send/Recv Log not supported
Jan 06 18:17:50 blarch kernel: ata3.00: supports DRM functions and may not be fully accessible
Jan 06 18:17:50 blarch kernel: ata3.00: NCQ Send/Recv Log not supported
Jan 06 18:17:50 blarch kernel: ata3.00: configured for UDMA/133
Jan 06 18:17:50 blarch kernel: [drm] UVD and UVD ENC initialized successfully.
Jan 06 18:17:50 blarch kernel: [drm] VCE initialized successfully.
Jan 06 18:17:50 blarch kernel: nvme nvme0: Shutdown timeout set to 10 seconds
Jan 06 18:17:50 blarch kernel: nvme nvme0: ctrl returned bogus length: 16 for NVME_NIDT_EUI64
Jan 06 18:17:50 blarch kernel: ahci 0000:0c:00.0: failed stop FIS RX (-16)
Jan 06 18:17:50 blarch kernel: ------------[ cut here ]------------
Jan 06 18:17:50 blarch kernel: WARNING: CPU: 14 PID: 257 at drivers/ata/libata-eh.c:4167 ata_scsi_port_error_handler.cold+0x36/0x3d [libata]
Jan 06 18:17:50 blarch kernel: Modules linked in: fuse devlink xt_CHECKSUM ipt_MASQUERADE xt_conntrack ipt_REJECT xt_tcpudp nf_nat_tftp nf_conntrack_tftp nft_objref tun nf_conntrack_netbios_ns nf_conntrack_broadcast nft_fib_inet nft_fib_ip>
Jan 06 18:17:50 blarch kernel: chash snd_hda_codec_generic gpu_sched wmi_bmof crct10dif_pclmul crc32_pclmul ghash_clmulni_intel mxm_wmi ttm btusb snd_hda_codec_hdmi pcbc btrtl btbcm drm_kms_helper btintel snd_hda_intel bluetooth snd_hda_c>
Jan 06 18:17:50 blarch kernel: vfio
Jan 06 18:17:50 blarch kernel: CPU: 14 PID: 257 Comm: scsi_eh_0 Tainted: G W 4.19.92-1-lts #1
Jan 06 18:17:50 blarch kernel: Hardware name: To Be Filled By O.E.M. To Be Filled By O.E.M./X570 Taichi, BIOS P2.70 11/25/2019
Jan 06 18:17:50 blarch kernel: RIP: 0010:ata_scsi_port_error_handler.cold+0x36/0x3d [libata]
Jan 06 18:17:50 blarch kernel: Code: 0f 0b e9 ab 65 ff ff 48 c7 c7 90 c0 58 c0 e8 81 4d 16 e7 0f 0b 48 8b 4b 08 e9 1b 69 ff ff 48 c7 c7 90 c0 58 c0 e8 6a 4d 16 e7 <0f> 0b e9 76 62 ff ff 48 c7 c7 90 c0 58 c0 e8 57 4d 16 e7 0f 0b e9
Jan 06 18:17:50 blarch kernel: RSP: 0018:ffffad2b43cebe28 EFLAGS: 00010246
Jan 06 18:17:50 blarch kernel: RAX: 0000000000000024 RBX: ffff9489d6e5c000 RCX: 0000000000000000
Jan 06 18:17:50 blarch kernel: RDX: 0000000000000000 RSI: ffff9489de9965b8 RDI: ffff9489de9965b8
Jan 06 18:17:50 blarch kernel: RBP: ffff9489daa83000 R08: ffff9489de9965b8 R09: ffff9489ff32d0c0
Jan 06 18:17:50 blarch kernel: R10: 000000000000063e R11: 000000000001ccac R12: ffff9489d6e5c000
Jan 06 18:17:50 blarch kernel: R13: ffffad2b43cbb8d0 R14: ffff9489d6e5e040 R15: ffff9489d68c1dc0
Jan 06 18:17:50 blarch kernel: FS: 0000000000000000(0000) GS:ffff9489de980000(0000) knlGS:0000000000000000
Jan 06 18:17:50 blarch kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jan 06 18:17:50 blarch kernel: CR2: 00007f23ac9ac000 CR3: 000000077aa2e000 CR4: 0000000000340ee0
Jan 06 18:17:50 blarch kernel: Call Trace:
Jan 06 18:17:50 blarch kernel: ata_scsi_error+0x91/0xc0 [libata]
Jan 06 18:17:50 blarch kernel: scsi_error_handler+0xbf/0x5d0 [scsi_mod]
Jan 06 18:17:50 blarch kernel: kthread+0xfb/0x130
Jan 06 18:17:50 blarch kernel: ? scsi_eh_get_sense+0x1f0/0x1f0 [scsi_mod]
Jan 06 18:17:50 blarch kernel: ? kthread_park+0x80/0x80
Jan 06 18:17:50 blarch kernel: ret_from_fork+0x22/0x40
Jan 06 18:17:50 blarch kernel: ---[ end trace 2057f1aba5903032 ]---
Jan 06 18:17:50 blarch kernel: OOM killer enabled.
Jan 06 18:17:50 blarch kernel: Restarting tasks ... done.
Jan 06 18:17:50 blarch kernel: PM: suspend exit
Jan 06 18:17:50 blarch kernel: audit: type=1130 audit(1578363470.479:131): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jan 06 18:17:50 blarch kernel: audit: type=1131 audit(1578363470.479:132): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jan 06 18:17:50 blarch audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jan 06 18:17:50 blarch audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jan 06 18:17:50 blarch systemd-sleep[2004]: System resumed.
Jan 06 18:17:50 blarch systemd[1]: systemd-suspend.service: Succeeded.
Jan 06 18:17:50 blarch systemd[1]: Started Suspend.
Jan 06 18:17:50 blarch systemd[1]: Stopped target Sleep.
Jan 06 18:17:50 blarch systemd[1]: Reached target Suspend.
Jan 06 18:17:50 blarch systemd[1]: Stopped target Suspend.
Jan 06 18:17:50 blarch systemd-logind[542]: Operation 'sleep' finished.
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.4973] manager: sleep: wake requested (sleeping: yes enabled: yes)
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.4974] device (enp8s0): state change: activated -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
Jan 06 18:17:50 blarch kernel: ata1: SATA link down (SStatus 0 SControl 300)
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.5896] dhcp4 (enp8s0): canceled DHCP transaction
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.5896] dhcp4 (enp8s0): state changed bound -> done
Jan 06 18:17:50 blarch dnsmasq[806]: no servers found in /etc/resolv.conf, will retry
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.5960] manager: NetworkManager state is now CONNECTED_GLOBAL
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.6261] device (enp8s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'managed')
Jan 06 18:17:50 blarch dbus-daemon[537]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.3' (uid=0 pid=544 comm="/usr/bin/NetworkManager --no->
Jan 06 18:17:50 blarch systemd[1]: Starting Network Manager Script Dispatcher Service...
Jan 06 18:17:50 blarch kernel: IPv6: ADDRCONF(NETDEV_UP): enp8s0: link is not ready
Jan 06 18:17:50 blarch dbus-daemon[537]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jan 06 18:17:50 blarch systemd[1]: Started Network Manager Script Dispatcher Service.
Jan 06 18:17:50 blarch audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jan 06 18:17:50 blarch kernel: audit: type=1130 audit(1578363470.619:133): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=succes>
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.6507] manager: NetworkManager state is now CONNECTED_LOCAL
Jan 06 18:17:50 blarch kernel: IPv6: ADDRCONF(NETDEV_UP): enp8s0: link is not ready
Jan 06 18:17:53 blarch kernel: igb 0000:08:00.0 enp8s0: igb: enp8s0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5902] device (enp8s0): carrier: link connected
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5903] device (enp8s0): state change: unavailable -> disconnected (reason 'carrier-changed', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5911] policy: auto-activating connection 'Wired connection 1' (8e1bd89a-166a-3da1-94c0-696dc72dfaae)
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5913] device (enp8s0): Activation: starting connection 'Wired connection 1' (8e1bd89a-166a-3da1-94c0-696dc72dfaae)
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5914] device (enp8s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5915] manager: NetworkManager state is now CONNECTING
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5916] device (enp8s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5952] device (enp8s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.5953] dhcp4 (enp8s0): activation: beginning transaction (timeout in 45 seconds)
Jan 06 18:17:53 blarch kernel: IPv6: ADDRCONF(NETDEV_CHANGE): enp8s0: link becomes ready
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option dhcp_lease_time => '43200'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option domain_name_servers => '192.168.200.1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option expiry => '1578406673'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option host_name => 'blarch'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option interface_mtu => '1500'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option ip_address => '192.168.200.194'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option next_server => '192.168.200.1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option requested_broadcast_address => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option requested_dhcp_server_identifier => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option requested_domain_name => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6020] dhcp4 (enp8s0): option requested_domain_name_servers => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_domain_search => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_host_name => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_interface_mtu => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_ms_classless_static_routes => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_nis_domain => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_nis_servers => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_ntp_servers => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_rfc3442_classless_static_routes => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_root_path => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_routers => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_static_routes => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_subnet_mask => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_time_offset => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option requested_wpad => '1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option routers => '192.168.200.1'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): option subnet_mask => '255.255.255.0'
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6021] dhcp4 (enp8s0): state changed unknown -> bound
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6026] device (enp8s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6036] device (enp8s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6037] device (enp8s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6039] manager: NetworkManager state is now CONNECTED_LOCAL
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6043] manager: NetworkManager state is now CONNECTED_SITE
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6043] policy: set 'Wired connection 1' (enp8s0) as default for IPv4 routing and DNS
Jan 06 18:17:53 blarch dnsmasq[806]: reading /etc/resolv.conf
Jan 06 18:17:53 blarch dnsmasq[806]: using nameserver 192.168.200.1#53
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.6054] device (enp8s0): Activation: successful, device activated.
Jan 06 18:17:53 blarch NetworkManager[544]: <info> [1578363473.9212] manager: NetworkManager state is now CONNECTED_GLOBALOffline
I may be reading your logs incorrectly. Here is the what I see:
Jan 06 18:17:50 blarch systemd-logind[542]: Operation 'sleep' finished.
Jan 06 18:17:50 blarch NetworkManager[544]: <info> [1578363470.4973] manager: sleep: wake requested (sleeping: yes enabled: yes)It looks like it reached sleep status but was waken up by Network Manager.
Offline
I double checked my bios to make sure wake on lan is disabled (it is), and followed the wiki on wake on lan to make sure it is disabled and tried suspending again, but it still doesn't work and I still get the same exact messages in my journal.
Offline
WOL isn't the only event that can trigger an awake from suspend. Have you looked at output of
cat /proc/acpi/wakeupOffline
Yes, I've tried disabling all devices in
/proc/acpi/wakeupbut get the same result. I do think that it is a kernel or hardware issue because I get this error message only when I try suspending:
Jan 06 18:17:43 blarch kernel: ahci 0000:0c:00.0: failed stop FIS RX (-16)
Jan 06 18:17:43 blarch kernel: ------------[ cut here ]------------
Jan 06 18:17:43 blarch kernel: WARNING: CPU: 14 PID: 257 at drivers/ata/libata-eh.c:4167 ata_scsi_port_error_handler.cold+0x36/0x3d [libata]
Jan 06 18:17:43 blarch kernel: Modules linked in: fuse devlink xt_CHECKSUM ipt_MASQUERADE xt_conntrack ipt_REJECT xt_tcpudp nf_nat_tftp nf_conntrack_tftp nft_objref tun nf_conntrack_netbios_ns nf_conntrack_broadcast nft_fib_inet nft_fib_ip>
Jan 06 18:17:43 blarch kernel: chash snd_hda_codec_generic gpu_sched wmi_bmof crct10dif_pclmul crc32_pclmul ghash_clmulni_intel mxm_wmi ttm btusb snd_hda_codec_hdmi pcbc btrtl btbcm drm_kms_helper btintel snd_hda_intel bluetooth snd_hda_c>
Jan 06 18:17:43 blarch kernel: vfio
Jan 06 18:17:43 blarch kernel: CPU: 14 PID: 257 Comm: scsi_eh_0 Not tainted 4.19.92-1-lts #1
Jan 06 18:17:43 blarch kernel: Hardware name: To Be Filled By O.E.M. To Be Filled By O.E.M./X570 Taichi, BIOS P2.70 11/25/2019
Jan 06 18:17:43 blarch kernel: RIP: 0010:ata_scsi_port_error_handler.cold+0x36/0x3d [libata]
Jan 06 18:17:43 blarch kernel: Code: 0f 0b e9 ab 65 ff ff 48 c7 c7 90 c0 58 c0 e8 81 4d 16 e7 0f 0b 48 8b 4b 08 e9 1b 69 ff ff 48 c7 c7 90 c0 58 c0 e8 6a 4d 16 e7 <0f> 0b e9 76 62 ff ff 48 c7 c7 90 c0 58 c0 e8 57 4d 16 e7 0f 0b e9
Jan 06 18:17:43 blarch kernel: RSP: 0018:ffffad2b43cebe28 EFLAGS: 00010246
Jan 06 18:17:43 blarch kernel: RAX: 0000000000000024 RBX: ffff9489d6e5c000 RCX: 0000000000000000
Jan 06 18:17:43 blarch kernel: RDX: 0000000000000000 RSI: ffff9489de9965b8 RDI: ffff9489de9965b8
Jan 06 18:17:43 blarch kernel: RBP: ffff9489daa83000 R08: ffff9489de9965b8 R09: ffff9489ff32d0c0
Jan 06 18:17:43 blarch kernel: R10: 00000000000005fe R11: 000000000001e3f0 R12: ffff9489d6e5c000
Jan 06 18:17:43 blarch kernel: R13: ffffad2b43cbb8d0 R14: ffff9489d6e5e040 R15: ffff9489d68c1dc0
Jan 06 18:17:43 blarch kernel: FS: 0000000000000000(0000) GS:ffff9489de980000(0000) knlGS:0000000000000000
Jan 06 18:17:43 blarch kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jan 06 18:17:43 blarch kernel: CR2: 00005623db333498 CR3: 00000007db728000 CR4: 0000000000340ee0
Jan 06 18:17:43 blarch kernel: Call Trace:
Jan 06 18:17:43 blarch kernel: ata_scsi_error+0x91/0xc0 [libata]
Jan 06 18:17:43 blarch kernel: scsi_error_handler+0xbf/0x5d0 [scsi_mod]
Jan 06 18:17:43 blarch kernel: kthread+0xfb/0x130
Jan 06 18:17:43 blarch kernel: ? scsi_eh_get_sense+0x1f0/0x1f0 [scsi_mod]
Jan 06 18:17:43 blarch kernel: ? kthread_park+0x80/0x80
Jan 06 18:17:43 blarch kernel: ret_from_fork+0x22/0x40
Jan 06 18:17:43 blarch kernel: ---[ end trace 2057f1aba5903031 ]---I'm just not sure on what I can do to fix it.
Offline
Pages: 1