You are not logged in.

#1 2019-04-24 08:55:33

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Keypress hang system after restore from suspend

I suspend my laptop via systemd service and i3lock, it works just as it should on one machine and totally freezes on another. I suspend my laptop with command systemctl suspend , after that i3lock locks screen and then suspend laptop. When I resume laptop I can only type 1-2 characters and I may confirm this by indicator and then all my input from keyboard seems like not triggering event of keypress because indicator not showing as if I was typing and I can't unlock my laptop anyhow, it seems like it freezes. 1 out of 4 tries it correctly unlocks screen and all keyboard input is showing in indicator, how can I debug further this trouble?

screenlock.service

[Unit]
Description=Starts i3lock on sleep
Before=sleep.target

[Service]
User=user
Type=forking
Environment=DISPLAY=:0
ExecStart=/usr/bin/i3lock -i /home/user/i3lock.png

[Install]
WantedBy=sleep.target

from journalctl only one record from i3lock Apr 24 11:19:49 computer i3lock[1151]: i3lock: X11 connection broke, did your server terminate?

journalctl
Apr 24 11:17:54 computer systemd[453]: Reached target Main User Target.
Apr 24 11:17:54 computer systemd[453]: Startup finished in 8.086s.
Apr 24 11:18:00 computer dbus-daemon[510]: [session uid=1000 pid=510] Activating via systemd: service name='org.gtk.vfs.UDisks2VolumeMonitor' unit='gvfs-udisks2-volume-monitor.service' requested by ':1.11' (uid=1000 pid=739 comm="nautilus ")
Apr 24 11:18:00 computer systemd[453]: Starting Virtual filesystem service - disk device monitor...
Apr 24 11:18:00 computer dbus-daemon[510]: [session uid=1000 pid=510] Successfully activated service 'org.gtk.vfs.UDisks2VolumeMonitor'
Apr 24 11:18:00 computer systemd[453]: Started Virtual filesystem service - disk device monitor.
Apr 24 11:18:00 computer dbus-daemon[510]: [session uid=1000 pid=510] Activating service name='ca.desrt.dconf' requested by ':1.11' (uid=1000 pid=739 comm="nautilus ")
Apr 24 11:18:00 computer dbus-daemon[510]: [session uid=1000 pid=510] Successfully activated service 'ca.desrt.dconf'
Apr 24 11:18:03 computer dbus-daemon[510]: [session uid=1000 pid=510] Activating via systemd: service name='org.gtk.vfs.Metadata' unit='gvfs-metadata.service' requested by ':1.11' (uid=1000 pid=739 comm="nautilus ")
Apr 24 11:18:03 computer systemd[453]: Starting Virtual filesystem metadata service...
Apr 24 11:18:03 computer dbus-daemon[510]: [session uid=1000 pid=510] Successfully activated service 'org.gtk.vfs.Metadata'
Apr 24 11:18:03 computer systemd[453]: Started Virtual filesystem metadata service.
Apr 24 11:18:37 computer dbus-daemon[510]: [session uid=1000 pid=510] Activating service name='org.gnome.gedit' requested by ':1.11' (uid=1000 pid=739 comm="nautilus ")
Apr 24 11:18:37 computer dbus-daemon[510]: [session uid=1000 pid=510] Successfully activated service 'org.gnome.gedit'
Apr 24 11:18:37 computer org.gnome.gedit[510]: Unable to init server: Could not connect: Connection refused
Apr 24 11:18:37 computer gedit[935]: cannot open display: 
Apr 24 11:18:39 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:18:41 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:18:41 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:18:41 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:19:49 computer at-spi-bus-launcher[639]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Apr 24 11:19:49 computer at-spi-bus-launcher[639]:       after 173 requests (173 known processed) with 0 events remaining.
Apr 24 11:19:49 computer dunst[471]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Apr 24 11:19:49 computer dunst[471]:       after 1135 requests (1135 known processed) with 0 events remaining.
Apr 24 11:19:49 computer systemd[453]: dunst.service: Main process exited, code=exited, status=1/FAILURE
Apr 24 11:19:49 computer systemd[453]: dunst.service: Failed with result 'exit-code'.
-- >> Apr 24 11:19:49 computer i3lock[1151]: i3lock: X11 connection broke, did your server terminate? 
Apr 24 11:19:50 computer systemd[453]: Stopping Virtual filesystem service - disk device monitor...
Apr 24 11:19:50 computer systemd[453]: Stopped target Main User Target.
Apr 24 11:19:50 computer systemd[453]: Stopping Virtual filesystem metadata service...
Apr 24 11:19:50 computer systemd[453]: Stopping D-Bus User Message Bus...
Apr 24 11:19:50 computer gvfsd[662]: A connection to the bus can't be made
Apr 24 11:19:50 computer systemd[453]: Stopping PulseAudio Sound System...
Apr 24 11:19:50 computer pulseaudio[477]: E: [alsa-sink-ALC255 Analog] alsa-sink.c: Error opening PCM device front:0: No such file or directory
Apr 24 11:19:50 computer pulseaudio[477]: E: [alsa-source-ALC255 Analog] alsa-source.c: Error opening PCM device front:0: No such file or directory
Apr 24 11:19:50 computer systemd[453]: Stopping Virtual filesystem service...
Apr 24 11:19:50 computer systemd[453]: Stopping Accessibility services bus...
Apr 24 11:19:50 computer systemd[453]: gvfs-udisks2-volume-monitor.service: Main process exited, code=killed, status=15/TERM
Apr 24 11:19:50 computer systemd[453]: gvfs-udisks2-volume-monitor.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Stopped Virtual filesystem service - disk device monitor.
Apr 24 11:19:50 computer systemd[453]: gvfs-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 24 11:19:50 computer systemd[453]: gvfs-metadata.service: Main process exited, code=killed, status=15/TERM
Apr 24 11:19:50 computer systemd[453]: gvfs-metadata.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Stopped Virtual filesystem metadata service.
Apr 24 11:19:50 computer systemd[453]: run-user-1000-gvfs.mount: Succeeded.
Apr 24 11:19:50 computer systemd[453]: dbus.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Stopped D-Bus User Message Bus.
Apr 24 11:19:50 computer systemd[453]: gvfs-daemon.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Stopped Virtual filesystem service.
Apr 24 11:19:50 computer systemd[453]: at-spi-dbus-bus.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Stopped Accessibility services bus.
Apr 24 11:19:50 computer systemd[453]: pulseaudio.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Stopped PulseAudio Sound System.
Apr 24 11:19:50 computer systemd[453]: Stopped target Basic System.
Apr 24 11:19:50 computer systemd[453]: Stopped target Paths.
Apr 24 11:19:50 computer systemd[453]: Stopped target Timers.
Apr 24 11:19:50 computer systemd[453]: Stopped target Sockets.
Apr 24 11:19:50 computer systemd[453]: dbus.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed D-Bus User Message Bus Socket.
Apr 24 11:19:50 computer systemd[453]: p11-kit-server.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed p11-kit server.
Apr 24 11:19:50 computer systemd[453]: gpg-agent-ssh.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Apr 24 11:19:50 computer systemd[453]: dirmngr.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed GnuPG network certificate management daemon.
Apr 24 11:19:50 computer systemd[453]: gpg-agent-browser.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 24 11:19:50 computer systemd[453]: gpg-agent.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed GnuPG cryptographic agent and passphrase cache.
Apr 24 11:19:50 computer systemd[453]: gpg-agent-extra.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Apr 24 11:19:50 computer systemd[453]: pulseaudio.socket: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Closed Sound System.
Apr 24 11:19:50 computer systemd[453]: Reached target Shutdown.
Apr 24 11:19:50 computer systemd[453]: systemd-exit.service: Succeeded.
Apr 24 11:19:50 computer systemd[453]: Started Exit the Session.
Apr 24 11:19:50 computer systemd[453]: Reached target Exit the Session.
Apr 24 11:19:50 computer systemd[454]: pam_unix(systemd-user:session): session closed for user user
journalctl -u screenlock.service 
i3lock[4512]: i3lock Cannot grab pointer/keyboard

Last edited by assertion9 (2019-04-29 16:28:24)

Offline

#2 2019-04-26 20:21:04

seth
Member
Registered: 2012-09-03
Posts: 51,173

Re: Keypress hang system after restore from suspend

Apr 24 11:18:37 computer gedit[935]: cannot open display: 
Apr 24 11:18:39 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:18:41 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:18:41 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:18:41 computer dunst[471]: WARNING: BadWindow (invalid Window parameter)
Apr 24 11:19:49 computer at-spi-bus-launcher[639]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Apr 24 11:19:49 computer at-spi-bus-launcher[639]:       after 173 requests (173 known processed) with 0 events remaining.
Apr 24 11:19:49 computer dunst[471]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Apr 24 11:19:49 computer dunst[471]:       after 1135 requests (1135 known processed) with 0 events remaining.
Apr 24 11:19:49 computer systemd[453]: dunst.service: Main process exited, code=exited, status=1/FAILURE
Apr 24 11:19:49 computer systemd[453]: dunst.service: Failed with result 'exit-code'.
-- >> Apr 24 11:19:49 computer i3lock[1151]: i3lock: X11 connection broke, did your server terminate? 

The session or X11 server crashed or the X11 server does no longer respond. i3lock might be the trigger but is unlikely the cause.
Does eg. slock behave "better"?

Online

#3 2019-04-27 05:15:16

ArchNoob24
Member
Registered: 2019-04-25
Posts: 7

Re: Keypress hang system after restore from suspend

edited.

Last edited by ArchNoob24 (2019-04-27 05:20:02)

Offline

#4 2019-04-27 09:46:00

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Re: Keypress hang system after restore from suspend

Unfortunately, no. It seems like it's not i3lock trouble, even if I exit i3 session and run from tty systemctl suspend, after resume it gets stuck after I enter 1 character, no response from keyboard, indicator continues blinking but I can't type anything and it leaves me no choice but reboot whole system. Tested on both linux-lts kernel and linux-hardened, though linux-lts simply freeze and cant even suspend.

Offline

#5 2019-04-27 10:38:57

seth
Member
Registered: 2012-09-03
Posts: 51,173

Re: Keypress hang system after restore from suspend

Try to cut out systemd, eg. use

rtcwake -m mem --date +10h

instead (that will re-wake the system after 10h automatically, but you can still resume it by pressing a key or whatever)

Online

#6 2019-04-28 02:11:45

maxpegua
Member
Registered: 2017-08-16
Posts: 25

Re: Keypress hang system after restore from suspend

I am having a similar problem, read Here
I don't i3 but dwm. I think it is something related to the new kernel and new hardware. I need to investigate more.

Offline

#7 2019-04-28 13:56:45

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Re: Keypress hang system after restore from suspend

maxpegua wrote:

I am having a similar problem, read Here
I don't i3 but dwm. I think it is something related to the new kernel and new hardware. I need to investigate more.

I experience total freeze after resume from suspend when I enter something, but if I wait 3-5 seconds, without typing, it goes resume system without freeze, strange behavior. Once I resumed without lock I entered symbol "s" in console and get continuous repeating "ssssssssssssssssssssss......" which seems like system interprets like I'm still holding key, but I didn't. Sadly, it has nothing to do with kernel, I used 4.14 and new, same result...

Offline

#8 2019-04-28 14:18:53

seth
Member
Registered: 2012-09-03
Posts: 51,173

Re: Keypress hang system after restore from suspend

Did you try rtcwake (or anything but systemd) to suspend?

Online

#9 2019-04-28 18:03:46

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Re: Keypress hang system after restore from suspend

seth wrote:

Did you try rtcwake (or anything but systemd) to suspend?

Still the same result with rtcwake, perfectly suspends but hung on system resume after interaction with keyboard. It worked well on my previous linux distribution, so I don't think it's a hardware issue, more like I messed up with some configuration. In recent topics on kernel issues, I found possible solution for similar problem, including intel-ucode in kernel parameters, but it didn't help either.

Offline

#10 2019-04-28 19:31:45

seth
Member
Registered: 2012-09-03
Posts: 51,173

Re: Keypress hang system after restore from suspend

µcode is mandatory (well, if you've got a modern CPU ;-)


I had hoped some service or sleep hook stumbled over its own feet.

Is it related to keyboard interaction?
Eg. if you play some mp3 file before S3, does it continue perfectly fine after the resume (until you press some keys)?
Do you have an external keyboard to try?
Is the internal one wired via usb or i2c?

Online

#11 2019-04-29 06:21:41

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Re: Keypress hang system after restore from suspend

I guess it's related to keyboard input. If I wait for 3-5 secnds it goes smoothly, but not every time, somethimes it hangs by itself, even if I dim my screen and then for example try to unlock with i3lock, so immediate input hang system as well. Music continues playing after resume and still if I interact with keyboard I can't then move mouse or enter input, but I still able to use fn keys, I can dim the display and change volume and brightness with notifications from dunst displaying as if nothing happened, but can't change music which I bind to XF86AudioNext and XF86AudioPrev. Maybe messed up with mkinitcpio hooks?

/etc/mkinitcpio
MODULES=()
BINARIES=()
FILES=()
HOOKS=(base udev autodetect modconf block filesystems keyboard fsck)
/boot/loader/entries/arch.conf
title Arch Linux
linux /vmlinuz-linux-hardened 
initrd /intel-ucode.img
initrd /initramfs-linux-hardened.img 
options root=/dev/nvme0n1p2 rw apparmor=1 security=apparmor

Unfortunately, I don't have any  external keyboard. How can I see which I have usb or i2c?

Last edited by assertion9 (2019-04-29 06:23:43)

Offline

#12 2019-04-29 07:06:53

seth
Member
Registered: 2012-09-03
Posts: 51,173

Re: Keypress hang system after restore from suspend

If lsusb shows the keyboard, it's on USB. Otherwise not.
If you've got a second system, run sshd on the troublesome for a remote login - dmesg and/or the xorg log may shed further light on why the input breaks down.
Also see whether you can switch to another VT (ctrl+alt+F1, F2, F3, …)

Online

#13 2019-04-29 09:59:47

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Re: Keypress hang system after restore from suspend

No keyboard listed in lsusb, then it's wired via i2c. Can't switch to another VT unless I wait. Here's what I get from remote machine calling suspend

 
Apr 29 12:34:44 computer kernel: OOM killer enabled.
Apr 29 12:34:44 computer kernel: Restarting tasks ... done.
Apr 29 12:34:44 computer systemd[1]: Starting Load/Save RF Kill Switch Status...
Apr 29 12:34:44 computer systemd-sleep[892]: System resumed.
Apr 29 12:34:44 computer systemd[1]: Started Load/Save RF Kill Switch Status.
Apr 29 12:34:44 computer audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:44 computer systemd[1]: systemd-suspend.service: Succeeded.
Apr 29 12:34:44 computer kernel: PM: suspend exit
Apr 29 12:34:44 computer kernel: audit: type=1130 audit(1556530484.296:57): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:44 computer audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:44 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:44 computer systemd[1]: Started Suspend.
Apr 29 12:34:44 computer systemd[1]: Stopped target Sleep.
Apr 29 12:34:44 computer systemd[1]: Reached target Suspend.
Apr 29 12:34:44 computer systemd[1]: Stopped target Suspend.
Apr 29 12:34:44 computer systemd-logind[414]: Operation 'sleep' finished.
Apr 29 12:34:44 computer kernel: audit: type=1130 audit(1556530484.299:58): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:44 computer kernel: audit: type=1131 audit(1556530484.299:59): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.3054] manager: sleep: wake requested (sleeping: yes  enabled: yes)
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.3054] device (wlp2s0): state change: config -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
Apr 29 12:34:44 computer systemd[1]: Stopped target Bluetooth.
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.3097] manager: NetworkManager state is now DISCONNECTED
Apr 29 12:34:44 computer wpa_supplicant[455]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlp2s0/drop_unicast_in_l2_multicast: No such file or directory
Apr 29 12:34:44 computer wpa_supplicant[455]: nl80211: Failed to set IPv4 unicast in multicast filter
Apr 29 12:34:44 computer wpa_supplicant[455]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlp2s0/drop_unicast_in_l2_multicast: No such file or directory
Apr 29 12:34:44 computer wpa_supplicant[455]: nl80211: Failed to set IPv4 unicast in multicast filter
Apr 29 12:34:44 computer wpa_supplicant[455]: nl80211: deinit ifname=p2p-dev-wlp2s0 disabled_11b_rates=0
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.3165] device (wlp2s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'managed')
Apr 29 12:34:44 computer wpa_supplicant[455]: nl80211: deinit ifname=wlp2s0 disabled_11b_rates=0
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.4634] device (wlp2s0): set-hw-addr: set MAC address to BA:32:F0:F9:5F:4A (scanning)
Apr 29 12:34:44 computer kernel: psmouse serio4: Failed to reset mouse on isa0060/serio4: -5
Apr 29 12:34:44 computer kernel: ath10k_pci 0000:02:00.0: unsupported HTC service id: 1536
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.6935] device (p2p-dev-wlp2s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'managed')
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.7761] sup-iface[0x11901d748f0,wlp2s0]: supports 5 scan SSIDs
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.7779] device (wlp2s0): supplicant interface state: starting -> ready
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.7780] device (p2p-dev-wlp2s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Apr 29 12:34:44 computer NetworkManager[862]: <info>  [1556530484.7788] device (wlp2s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Apr 29 12:34:45 computer wpa_supplicant[455]: wlp2s0: CTRL-EVENT-REGDOM-CHANGE init=BEACON_HINT type=UNKNOWN
Apr 29 12:34:48 computer kernel: atkbd serio0: Unknown key released (translated set 2, code 0x7c on isa0060/serio0).
Apr 29 12:34:48 computer kernel: atkbd serio0: Use 'setkeycodes 7c <keycode>' to make it known.
Apr 29 12:34:48 computer kernel: atkbd serio0: Unknown key released (translated set 2, code 0x7c on isa0060/serio0).
Apr 29 12:34:48 computer kernel: atkbd serio0: Use 'setkeycodes 7c <keycode>' to make it known.
Apr 29 12:34:49 computer systemd[1]: systemd-rfkill.service: Succeeded.
Apr 29 12:34:49 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:49 computer kernel: audit: type=1131 audit(1556530489.306:60): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:49 computer kernel: Bluetooth: hci0: using rampatch file: qca/rampatch_usb_00000302.bin
Apr 29 12:34:49 computer kernel: Bluetooth: hci0: QCA: patch rome 0x302 build 0x3e8, firmware rome 0x302 build 0x111
Apr 29 12:34:49 computer systemd[1]: Starting Load/Save RF Kill Switch Status...
Apr 29 12:34:49 computer systemd[1]: Started Load/Save RF Kill Switch Status.
Apr 29 12:34:49 computer audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:49 computer systemd[1]: Reached target Bluetooth.
Apr 29 12:34:49 computer kernel: audit: type=1130 audit(1556530489.446:61): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:49 computer kernel: Bluetooth: hci0: using NVM file: qca/nvm_usb_00000302.bin
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6682] policy: auto-activating connection 'WiredAssault' (89907f3a-bb60-4d83-8390-864eda533d36)
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6689] device (wlp2s0): Activation: starting connection 'WiredAssault' (89907f3a-bb60-4d83-8390-864eda533d36)
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6691] device (wlp2s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6695] manager: NetworkManager state is now CONNECTING
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6704] device (wlp2s0): set-hw-addr: reset MAC address to 3C:95:09:EF:E7:7D (preserve)
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6829] device (wlp2s0): supplicant interface state: ready -> disabled
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6829] device (p2p-dev-wlp2s0): supplicant management interface state: ready -> disabled
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6831] device (wlp2s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6835] device (wlp2s0): Activation: (wifi) access point 'WiredAssault' has security, but secrets are required.
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6835] device (wlp2s0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6838] sup-iface[0x11901d748f0,wlp2s0]: wps: type pbc start...
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6853] device (wlp2s0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6860] device (wlp2s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6864] device (wlp2s0): Activation: (wifi) connection 'WiredAssault' has security, and secrets exist.  No new secrets needed.
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6864] Config: added 'ssid' value 'WiredAssault'
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6864] Config: added 'scan_ssid' value '1'
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6864] Config: added 'bgscan' value 'simple:30:-80:86400'
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6865] Config: added 'key_mgmt' value 'WPA-PSK'
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6865] Config: added 'auth_alg' value 'OPEN'
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.6865] Config: added 'psk' value '<hidden>'
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.7088] device (wlp2s0): supplicant interface state: disabled -> inactive
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.7088] device (p2p-dev-wlp2s0): supplicant management interface state: disabled -> inactive
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.7214] device (wlp2s0): supplicant interface state: inactive -> scanning
Apr 29 12:34:49 computer NetworkManager[862]: <info>  [1556530489.7214] device (p2p-dev-wlp2s0): supplicant management interface state: inactive -> scanning
Apr 29 12:34:50 computer wpa_supplicant[455]: wlp2s0: CTRL-EVENT-REGDOM-CHANGE init=BEACON_HINT type=UNKNOWN
Apr 29 12:34:54 computer systemd[1]: systemd-rfkill.service: Succeeded.
Apr 29 12:34:54 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:54 computer kernel: audit: type=1131 audit(1556530494.452:62): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 12:34:54 computer wpa_supplicant[455]: wlp2s0: SME: Trying to authenticate with f8:1a:67:64:ce:9c (SSID='WiredAssault' freq=2452 MHz)
Apr 29 12:34:54 computer kernel: wlp2s0: authenticate with f8:1a:67:64:ce:9c
Apr 29 12:34:54 computer kernel: wlp2s0: send auth to f8:1a:67:64:ce:9c (try 1/3)
Apr 29 12:34:54 computer NetworkManager[862]: <info>  [1556530494.6280] device (wlp2s0): supplicant interface state: scanning -> authenticating
Apr 29 12:34:54 computer NetworkManager[862]: <info>  [1556530494.6281] device (p2p-dev-wlp2s0): supplicant management interface state: scanning -> authenticating
Apr 29 12:34:54 computer kernel: wlp2s0: authenticated
Apr 29 12:34:54 computer wpa_supplicant[455]: wlp2s0: Trying to associate with f8:1a:67:64:ce:9c (SSID='WiredAssault' freq=2452 MHz)
Apr 29 12:34:54 computer kernel: wlp2s0: associate with f8:1a:67:64:ce:9c (try 1/3)
Apr 29 12:34:54 computer kernel: wlp2s0: RX AssocResp from f8:1a:67:64:ce:9c (capab=0x431 status=0 aid=1)
Apr 29 12:34:54 computer wpa_supplicant[455]: wlp2s0: Associated with f8:1a:67:64:ce:9c
Apr 29 12:34:54 computer wpa_supplicant[455]: wlp2s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 29 12:34:54 computer kernel: wlp2s0: associated

Also I tried to disable all services and applications, when I loaded i3 get warning errors

After resume from suspend I get this and this or

ath10k_pci 0000:02:00.0: Could not init core: -110

when trying to poweroff system.

Offline

#14 2019-04-29 15:12:20

seth
Member
Registered: 2012-09-03
Posts: 51,173

Re: Keypress hang system after restore from suspend

Looky:

Apr 29 12:34:48 computer kernel: atkbd serio0: Unknown key released (translated set 2, code 0x7c on isa0060/serio0).
Apr 29 12:34:48 computer kernel: atkbd serio0: Use 'setkeycodes 7c <keycode>' to make it known.
Apr 29 12:34:48 computer kernel: atkbd serio0: Unknown key released (translated set 2, code 0x7c on isa0060/serio0).
Apr 29 12:34:48 computer kernel: atkbd serio0: Use 'setkeycodes 7c <keycode>' to make it known.

From the context it seems as if NM tries to fake a key event (possibly to trigger some wifi/bt switch) - could also be the rfkill.service.

What if you stop NM before suspending?
a) does the message still show up?
b) does the problem remain?

Online

#15 2019-04-29 16:25:00

assertion9
Banned
Registered: 2019-04-13
Posts: 50

Re: Keypress hang system after restore from suspend

Disabled NM service. Message dont'n show up, but system again hangs, now unknown key is detected by atkbd Apr 29 19:04:15 computer kernel: atkbd serio0: Unknown key released (translated set 2, code 0x7c on isa0060/serio0).

It suggests setkeycodes 7c <keycode>, but how do I know keycode if it hangs on any input? Maybe I should manually load xmodmap in xinitrc on boot? Or xmodmap is only for remapping? Currently my xinitrc doesn't include any manipulation with keycodes.

Apr 29 19:04:15 computer kernel: PM: suspend exit
Apr 29 19:04:15 computer systemd[1]: systemd-suspend.service: Succeeded.
Apr 29 19:04:15 computer systemd[1]: Started Suspend.
Apr 29 19:04:15 computer systemd[1]: Stopped target Sleep.
Apr 29 19:04:15 computer systemd[1]: Reached target Suspend.
Apr 29 19:04:15 computer systemd[1]: Stopped target Suspend.
Apr 29 19:04:15 computer systemd-logind[424]: Operation 'sleep' finished.
Apr 29 19:04:15 computer audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:15 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:15 computer kernel: audit: type=1130 audit(1556553855.323:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:15 computer kernel: audit: type=1131 audit(1556553855.323:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:15 computer systemd[1]: Stopped target Bluetooth.
Apr 29 19:04:15 computer kernel: atkbd serio0: Unknown key released (translated set 2, code 0x7c on isa0060/serio0).
Apr 29 19:04:15 computer kernel: atkbd serio0: Use 'setkeycodes 7c <keycode>' to make it known.
Apr 29 19:04:16 computer wpa_supplicant[465]: wlp2s0: CTRL-EVENT-REGDOM-CHANGE init=BEACON_HINT type=UNKNOWN
Apr 29 19:04:17 computer kernel: Bluetooth: hci0: using rampatch file: qca/rampatch_usb_00000302.bin
Apr 29 19:04:17 computer kernel: Bluetooth: hci0: QCA: patch rome 0x302 build 0x3e8, firmware rome 0x302 build 0x111
Apr 29 19:04:17 computer systemd[1]: Reached target Bluetooth.
Apr 29 19:04:17 computer kernel: Bluetooth: hci0: using NVM file: qca/nvm_usb_00000302.bin
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: SME: Trying to authenticate with f8:1a:67:64:ce:9c (SSID='Jeka' freq=2452 MHz)
Apr 29 19:04:20 computer kernel: wlp2s0: authenticate with f8:1a:67:64:ce:9c
Apr 29 19:04:20 computer kernel: wlp2s0: send auth to f8:1a:67:64:ce:9c (try 1/3)
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: Trying to associate with f8:1a:67:64:ce:9c (SSID='Jeka' freq=2452 MHz)
Apr 29 19:04:20 computer kernel: wlp2s0: authenticated
Apr 29 19:04:20 computer kernel: wlp2s0: associate with f8:1a:67:64:ce:9c (try 1/3)
Apr 29 19:04:20 computer kernel: wlp2s0: RX AssocResp from f8:1a:67:64:ce:9c (capab=0x431 status=0 aid=1)
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: Associated with f8:1a:67:64:ce:9c
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 29 19:04:20 computer kernel: wlp2s0: associated
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: WPA: Key negotiation completed with f8:1a:67:64:ce:9c [PTK=CCMP GTK=CCMP]
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: CTRL-EVENT-CONNECTED - Connection to f8:1a:67:64:ce:9c completed [id=0 id_str=]
Apr 29 19:04:20 computer wpa_supplicant[465]: wlp2s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-54 noise=-111 txrate=1000
Apr 29 19:04:22 computer systemd[1]: systemd-rfkill.service: Succeeded.
Apr 29 19:04:22 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:22 computer kernel: audit: type=1131 audit(1556553862.296:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:23 computer kernel: ACPI Error: No installed handler for fixed event - PowerButton (2), disabling (20181213/evevent-257)
Apr 29 19:04:25 computer systemd-logind[424]: Power key pressed.
Apr 29 19:04:25 computer systemd-logind[424]: Powering Off...
Apr 29 19:04:25 computer systemd-logind[424]: System is powering down.
Apr 29 19:04:25 computer systemd[1]: Stopped target Bluetooth.
Apr 29 19:04:25 computer systemd[1]: Starting Generate shutdown-ramfs...
Apr 29 19:04:25 computer systemd[1]: lvm2-lvmpolld.socket: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Closed LVM2 poll daemon socket.
Apr 29 19:04:25 computer systemd[1]: Stopped target Graphical Interface.
Apr 29 19:04:25 computer systemd[1]: Stopping Daemon for power management...
Apr 29 19:04:25 computer login[449]: pam_unix(login:session): session closed for user user
Apr 29 19:04:25 computer at-spi-bus-launcher[731]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Apr 29 19:04:25 computer at-spi-bus-launcher[731]:       after 49 requests (49 known processed) with 0 events remaining.
Apr 29 19:04:25 computer polkitd[464]: Unregistered Authentication Agent for unix-session:1 (system bus name :1.40, object path /org/gnome/PolicyKit1/AuthenticationAgent, locale en_US.UTF-8) (disconnected from bus)
Apr 29 19:04:25 computer dunst[471]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Apr 29 19:04:25 computer dunst[471]:       after 633 requests (633 known processed) with 0 events remaining.
Apr 29 19:04:25 computer systemd[458]: dunst.service: Main process exited, code=exited, status=1/FAILURE
Apr 29 19:04:25 computer systemd[458]: dunst.service: Failed with result 'exit-code'.
Apr 29 19:04:25 computer systemd[1]: Stopping Session 1 of user user.
Apr 29 19:04:25 computer systemd[1]: Stopped target Sound Card.
Apr 29 19:04:25 computer systemd[1]: Stopping RealtimeKit Scheduling Policy Service...
Apr 29 19:04:25 computer systemd[1]: Stopped target Timers.
Apr 29 19:04:25 computer systemd[1]: systemd-tmpfiles-clean.timer: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Apr 29 19:04:25 computer systemd[1]: logrotate.timer: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Daily rotation of log files.
Apr 29 19:04:25 computer systemd[1]: shadow.timer: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Daily verification of password and group files.
Apr 29 19:04:25 computer systemd[1]: Stopping Authorization Manager...
Apr 29 19:04:25 computer systemd[1]: Stopped target Multi-User System.
Apr 29 19:04:25 computer systemd[1]: Stopped target Login Prompts.
Apr 29 19:04:25 computer systemd[1]: Stopping Getty on tty1...
Apr 29 19:04:25 computer systemd[1]: powertop.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Powertop tunings.
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=powertop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer systemd[1]: Stopping Advanced key-value store...
Apr 29 19:04:25 computer systemd[1]: man-db.timer: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Daily man-db regeneration.
Apr 29 19:04:25 computer systemd[1]: Stopped target System Time Synchronized.
Apr 29 19:04:25 computer systemd[1]: Stopped target System Time Set.
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.173:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=powertop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer systemd[1]: systemd-rfkill.socket: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Apr 29 19:04:25 computer systemd[1]: getty@tty1.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Getty on tty1.
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=getty@tty1 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.180:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=getty@tty1 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer mkinitcpio[1381]: ==> Starting build: none
Apr 29 19:04:25 computer mkinitcpio[1381]:   -> Running build hook: [sd-shutdown]
Apr 29 19:04:25 computer systemd[1]: rtkit-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 29 19:04:25 computer systemd[1]: rtkit-daemon.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped RealtimeKit Scheduling Policy Service.
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=rtkit-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer systemd[1]: upower.service: Main process exited, code=killed, status=15/TERM
Apr 29 19:04:25 computer systemd[1]: upower.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Daemon for power management.
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=upower comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.200:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=rtkit-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.200:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=upower comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer systemd-logind[424]: Session 1 logged out. Waiting for processes to exit.
Apr 29 19:04:25 computer systemd[1]: Removed slice system-getty.slice.
Apr 29 19:04:25 computer systemd[1]: polkit.service: Main process exited, code=killed, status=15/TERM
Apr 29 19:04:25 computer systemd[1]: polkit.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Authorization Manager.
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=polkit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.213:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=polkit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer redis-server[448]: 448:M 29 Apr 2019 19:04:25.222 # User requested shutdown...
Apr 29 19:04:25 computer redis-server[448]: 448:M 29 Apr 2019 19:04:25.222 * Saving the final RDB snapshot before exiting.
Apr 29 19:04:25 computer redis-server[448]: 448:M 29 Apr 2019 19:04:25.223 * DB saved on disk
Apr 29 19:04:25 computer redis-server[448]: 448:M 29 Apr 2019 19:04:25.223 * Removing the pid file.
Apr 29 19:04:25 computer redis-server[448]: 448:M 29 Apr 2019 19:04:25.223 # Redis is now ready to exit, bye bye...
Apr 29 19:04:25 computer systemd[1]: redis.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Stopped Advanced key-value store.
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=redis comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.223:51): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=redis comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer mkinitcpio[1381]: ==> Build complete.
Apr 29 19:04:25 computer systemd[1]: mkinitcpio-generate-shutdown-ramfs.service: Succeeded.
Apr 29 19:04:25 computer systemd[1]: Started Generate shutdown-ramfs.
Apr 29 19:04:25 computer audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=mkinitcpio-generate-shutdown-ramfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=mkinitcpio-generate-shutdown-ramfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1130 audit(1556553865.340:52): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=mkinitcpio-generate-shutdown-ramfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:25 computer kernel: audit: type=1131 audit(1556553865.340:53): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=mkinitcpio-generate-shutdown-ramfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: session-1.scope: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Session 1 of user user.
Apr 29 19:04:26 computer systemd[1]: Stopping Login Service...
Apr 29 19:04:26 computer systemd[1]: Stopping User Manager for UID 1000...
Apr 29 19:04:26 computer systemd-logind[424]: Removed session 1.
Apr 29 19:04:26 computer systemd[458]: Stopped target Main User Target.
Apr 29 19:04:26 computer systemd[458]: Stopping PulseAudio Sound System...
Apr 29 19:04:26 computer systemd[458]: Stopping Accessibility services bus...
Apr 29 19:04:26 computer systemd[458]: Stopping Virtual filesystem service...
Apr 29 19:04:26 computer systemd[458]: Stopping D-Bus User Message Bus...
Apr 29 19:04:26 computer systemd[1]: run-user-1000-gvfs.mount: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Unmounted /run/user/1000/gvfs.
Apr 29 19:04:26 computer systemd[458]: run-user-1000-gvfs.mount: Succeeded.
Apr 29 19:04:26 computer systemd[458]: gvfs-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 29 19:04:26 computer systemd[458]: gvfs-daemon.service: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Stopped Virtual filesystem service.
Apr 29 19:04:26 computer systemd[458]: at-spi-dbus-bus.service: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Stopped Accessibility services bus.
Apr 29 19:04:26 computer systemd[458]: dbus.service: Succeeded.
Apr 29 19:04:26 computer pulseaudio[483]: W: [pulseaudio] module.c: After module unload, module 'module-null-sink' was still loaded!
Apr 29 19:04:26 computer systemd[458]: Stopped D-Bus User Message Bus.
Apr 29 19:04:26 computer systemd[458]: pulseaudio.service: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Stopped PulseAudio Sound System.
Apr 29 19:04:26 computer systemd[458]: Stopped target Basic System.
Apr 29 19:04:26 computer systemd[458]: Stopped target Paths.
Apr 29 19:04:26 computer systemd[458]: Stopped target Sockets.
Apr 29 19:04:26 computer systemd[458]: gpg-agent-ssh.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Apr 29 19:04:26 computer systemd[458]: gpg-agent-extra.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Apr 29 19:04:26 computer systemd[458]: dbus.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed D-Bus User Message Bus Socket.
Apr 29 19:04:26 computer systemd[458]: p11-kit-server.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed p11-kit server.
Apr 29 19:04:26 computer systemd[458]: gpg-agent.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed GnuPG cryptographic agent and passphrase cache.
Apr 29 19:04:26 computer systemd[458]: gpg-agent-browser.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 29 19:04:26 computer systemd[458]: dirmngr.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed GnuPG network certificate management daemon.
Apr 29 19:04:26 computer systemd[458]: Stopped target Timers.
Apr 29 19:04:26 computer systemd[458]: pulseaudio.socket: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Closed Sound System.
Apr 29 19:04:26 computer systemd[458]: Reached target Shutdown.
Apr 29 19:04:26 computer systemd[458]: systemd-exit.service: Succeeded.
Apr 29 19:04:26 computer systemd[458]: Started Exit the Session.
Apr 29 19:04:26 computer systemd[458]: Reached target Exit the Session.
Apr 29 19:04:26 computer systemd[460]: pam_unix(systemd-user:session): session closed for user user
Apr 29 19:04:26 computer systemd[1]: user@1000.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped User Manager for UID 1000.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=user@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Stopping User Runtime Directory /run/user/1000...
Apr 29 19:04:26 computer kernel: audit: type=1131 audit(1556553866.220:54): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=user@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: run-user-1000.mount: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Unmounted /run/user/1000.
Apr 29 19:04:26 computer systemd[1]: user-runtime-dir@1000.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped User Runtime Directory /run/user/1000.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=user-runtime-dir@1000 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Removed slice User Slice of UID 1000.
Apr 29 19:04:26 computer wpa_supplicant[465]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlp2s0/drop_unicast_in_l2_multicast: No such file or directory
Apr 29 19:04:26 computer wpa_supplicant[465]: nl80211: Failed to set IPv4 unicast in multicast filter
Apr 29 19:04:26 computer wpa_supplicant[465]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlp2s0/drop_unicast_in_l2_multicast: No such file or directory
Apr 29 19:04:26 computer wpa_supplicant[465]: nl80211: Failed to set IPv4 unicast in multicast filter
Apr 29 19:04:26 computer wpa_supplicant[465]: nl80211: deinit ifname=p2p-dev-wlp2s0 disabled_11b_rates=0
Apr 29 19:04:26 computer systemd[1]: Stopping D-Bus System Message Bus...
Apr 29 19:04:26 computer systemd[1]: Stopping Permit User Sessions...
Apr 29 19:04:26 computer systemd[1]: systemd-user-sessions.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Permit User Sessions.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-user-sessions comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Stopped target Network.
Apr 29 19:04:26 computer systemd[1]: Stopping WPA supplicant...
Apr 29 19:04:26 computer systemd[1]: Stopped target Remote File Systems.
Apr 29 19:04:26 computer systemd[1]: dbus.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped D-Bus System Message Bus.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=dbus comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer wpa_supplicant[465]: p2p-dev-wlp2s0: CTRL-EVENT-TERMINATING
Apr 29 19:04:26 computer kernel: wlp2s0: deauthenticating from f8:1a:67:64:ce:9c by local choice (Reason: 3=DEAUTH_LEAVING)
Apr 29 19:04:26 computer wpa_supplicant[465]: wlp2s0: CTRL-EVENT-DISCONNECTED bssid=f8:1a:67:64:ce:9c reason=3 locally_generated=1
Apr 29 19:04:26 computer wpa_supplicant[465]: nl80211: deinit ifname=wlp2s0 disabled_11b_rates=0
Apr 29 19:04:26 computer wpa_supplicant[465]: wlp2s0: CTRL-EVENT-TERMINATING
Apr 29 19:04:26 computer systemd[1]: wpa_supplicant.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped WPA supplicant.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=wpa_supplicant comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-logind.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Login Service.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-logind comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Stopped target Basic System.
Apr 29 19:04:26 computer systemd[1]: Stopped target Slices.
Apr 29 19:04:26 computer systemd[1]: Stopped target Paths.
Apr 29 19:04:26 computer systemd[1]: Stopped target Sockets.
Apr 29 19:04:26 computer systemd[1]: dbus.socket: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Closed D-Bus System Message Bus Socket.
Apr 29 19:04:26 computer systemd[1]: Stopped target System Initialization.
Apr 29 19:04:26 computer systemd[1]: systemd-sysctl.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Apply Kernel Variables.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Stopped target Local Encrypted Volumes.
Apr 29 19:04:26 computer systemd[1]: systemd-ask-password-console.path: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Apr 29 19:04:26 computer systemd[1]: systemd-ask-password-wall.path: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Apr 29 19:04:26 computer systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Apr 29 19:04:26 computer systemd[1]: Stopping Load/Save Screen Backlight Brightness of backlight:intel_backlight...
Apr 29 19:04:26 computer systemd[1]: Stopping Load/Save Random Seed...
Apr 29 19:04:26 computer systemd[1]: Stopping Network Time Synchronization...
Apr 29 19:04:26 computer systemd[1]: systemd-update-done.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Update is Completed.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-done comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-journal-catalog-update.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Rebuild Journal Catalog.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: ldconfig.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Rebuild Dynamic Linker Cache.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=ldconfig comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Removed slice User and Session Slice.
Apr 29 19:04:26 computer audit[1489]: SYSTEM_SHUTDOWN pid=1489 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-backlight@backlight:intel_backlight.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Load/Save Screen Backlight Brightness of backlight:intel_backlight.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-backlight@backlight:intel_backlight comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-random-seed.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Load/Save Random Seed.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Removed slice system-systemd\x2dbacklight.slice.
Apr 29 19:04:26 computer systemd[1]: systemd-update-utmp.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-timesyncd.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Network Time Synchronization.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-tmpfiles-setup.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Create Volatile Files and Directories.
Apr 29 19:04:26 computer systemd[1]: Stopped target Local File Systems.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Unmounting /home...
Apr 29 19:04:26 computer systemd[1]: Unmounting /boot...
Apr 29 19:04:26 computer systemd[1]: Unmounting Temporary Directory (/tmp)...
Apr 29 19:04:26 computer systemd[1]: boot.mount: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Unmounted /boot.
Apr 29 19:04:26 computer systemd[1]: tmp.mount: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Unmounted Temporary Directory (/tmp).
Apr 29 19:04:26 computer systemd[1]: Stopped target Swap.
Apr 29 19:04:26 computer systemd[1]: systemd-fsck@dev-disk-by\x2duuid-CC81\x2d8051.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped File System Check on /dev/disk/by-uuid/CC81-8051.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-fsck@dev-disk-by\x2duuid-CC81\x2d8051 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: home.mount: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Unmounted /home.
Apr 29 19:04:26 computer systemd[1]: Reached target Unmount All Filesystems.
Apr 29 19:04:26 computer systemd[1]: systemd-fsck@dev-disk-by\x2duuid-a17716cb\x2d418f\x2d40fd\x2d95ee\x2d2cae55bfb02c.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped File System Check on /dev/disk/by-uuid/a17716cb-418f-40fd-95ee-2cae55bfb02c.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-fsck@dev-disk-by\x2duuid-a17716cb\x2d418f\x2d40fd\x2d95ee\x2d2cae55bfb02c comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Removed slice system-systemd\x2dfsck.slice.
Apr 29 19:04:26 computer systemd[1]: Stopped target Local File Systems (Pre).
Apr 29 19:04:26 computer systemd[1]: Stopping Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
Apr 29 19:04:26 computer systemd[1]: systemd-tmpfiles-setup-dev.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Create Static Device Nodes in /dev.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-sysusers.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Create System Users.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: systemd-remount-fs.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Remount Root and Kernel File Systems.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: lvm2-monitor.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=lvm2-monitor comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Stopping LVM2 metadata daemon...
Apr 29 19:04:26 computer systemd[1]: lvm2-lvmetad.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Stopped LVM2 metadata daemon.
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=lvm2-lvmetad comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Reached target Shutdown.
Apr 29 19:04:26 computer systemd[1]: Reached target Final Step.
Apr 29 19:04:26 computer systemd[1]: systemd-poweroff.service: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Started Power-Off.
Apr 29 19:04:26 computer audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-poweroff comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Apr 29 19:04:26 computer systemd[1]: Reached target Power-Off.
Apr 29 19:04:26 computer systemd[1]: lvm2-lvmetad.socket: Succeeded.
Apr 29 19:04:26 computer systemd[1]: Closed LVM2 metadata daemon socket.
Apr 29 19:04:26 computer systemd[1]: Shutting down.
Apr 29 19:04:26 computer kernel: printk: systemd-shutdow: 49 output lines suppressed due to ratelimiting
Apr 29 19:04:26 computer systemd-shutdown[1]: Syncing filesystems and block devices.
Apr 29 19:04:26 computer systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Apr 29 19:04:26 computer systemd-journald[257]: Journal stopped
-- Reboot --

Last edited by assertion9 (2019-04-29 16:37:26)

Offline

Board footer

Powered by FluxBB