Session re-locks and and re-suspends unintended after opening lid
The notebook locks and suspends unintended after ~20 seconds after opening the lid.
How to get this very often? Create two fresh XFCE 4.20 users and log in simultaneously.
The xfce4-power-manager --debug
log:
the user initiated suspending:
TRACE[xfpm-power-common.c:219] get_device_icon_name(): icon_suffix -symbolic, icon_base_length 20, upower_icon battery-full-charged-symbolic
TRACE[xfpm-manager.c:333] xfpm_manager_lid_changed_cb(): LID closed: ((XfpmLidTriggerAction) LID_TRIGGER_SUSPEND)
TRACE[xfpm-brightness-x11.c:148] xfpm_brightness_x11_setup(): No outputs have backlight property
TRACE[xfpm-brightness-polkit.c:85] helper_get_value(): Executing command: /usr/sbin/xfpm-power-backlight-helper --get-max-brightness
TRACE[xfpm-brightness-polkit.c:119] xfpm_brightness_polkit_setup(): get-max-brightness returned 937
TRACE[xfpm-brightness-polkit.c:128] xfpm_brightness_polkit_setup(): Windowing environment specific brightness control not available, controlled by sysfs helper: min_level=0 max_level=937
TRACE[xfpm-brightness-polkit.c:85] helper_get_value(): Executing command: /usr/sbin/xfpm-power-backlight-helper --get-brightness
TRACE[xfpm-brightness-polkit.c:141] xfpm_brightness_polkit_get_level(): get-brightness returned 937
TRACE[xfpm-brightness-polkit.c:160] xfpm_brightness_polkit_set_level(): Executing command: pkexec /usr/sbin/xfpm-power-backlight-helper --set-brightness 937
TRACE[xfpm-manager.c:333] xfpm_manager_lid_changed_cb(): LID opened: ((XfpmLidTriggerAction) LID_TRIGGER_SUSPEND)
TRACE[xfpm-dpms-x11.c:114] xfpm_dpms_x11_set_mode(): Setting DPMS mode 3
TRACE[xfpm-power-common.c:219] get_device_icon_name(): icon_suffix -symbolic, icon_base_length 10, upower_icon ac-adapter-symbolic
the second user:
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-power-common.c:219] get_device_icon_name(): icon_suffix -symbolic, icon_base_length 20, upower_icon battery-full-charged-symbolic
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-polkit.c:378] xfpm_polkit_changed_cb(): Auth changed
TRACE[xfpm-power-common.c:219] get_device_icon_name(): icon_suffix -symbolic, icon_base_length 20, upower_icon battery-full-charged-symbolic
TRACE[xfpm-manager.c:333] xfpm_manager_lid_changed_cb(): LID closed: ((XfpmLidTriggerAction) LID_TRIGGER_SUSPEND)
TRACE[xfpm-brightness-x11.c:148] xfpm_brightness_x11_setup(): No outputs have backlight property
TRACE[xfpm-brightness-polkit.c:85] helper_get_value(): Executing command: /usr/sbin/xfpm-power-backlight-helper --get-max-brightness
TRACE[xfpm-brightness-polkit.c:119] xfpm_brightness_polkit_setup(): get-max-brightness returned 937
TRACE[xfpm-brightness-polkit.c:128] xfpm_brightness_polkit_setup(): Windowing environment specific brightness control not available, controlled by sysfs helper: min_level=0 max_level=937
TRACE[xfpm-brightness-polkit.c:85] helper_get_value(): Executing command: /usr/sbin/xfpm-power-backlight-helper --get-brightness
TRACE[xfpm-brightness-polkit.c:141] xfpm_brightness_polkit_get_level(): get-brightness returned 937
TRACE[xfpm-brightness-polkit.c:160] xfpm_brightness_polkit_set_level(): Executing command: pkexec /usr/sbin/xfpm-power-backlight-helper --set-brightness 937
Error executing command as another user: Not authorized
This incident has been reported.
TRACE[xfpm-brightness-polkit.c:164] xfpm_brightness_polkit_set_level(): Failed to set value: Child process exited with code 127
TRACE[xfpm-manager.c:333] xfpm_manager_lid_changed_cb(): LID opened: ((XfpmLidTriggerAction) LID_TRIGGER_SUSPEND)
TRACE[xfpm-dpms-x11.c:129] xfpm_dpms_x11_set_mode(): DPMS mode 3 already set
TRACE[xfpm-power-common.c:219] get_device_icon_name(): icon_suffix -symbolic, icon_base_length 10, upower_icon ac-adapter-symbolic
The /var/messages
log:
Feb 12 12:04:40 node-calculate2 elogind-daemon[2375]: Lid closed.
Feb 12 12:04:40 node-calculate2 root[12848]: ACPI event unhandled: button/lid LID close
Feb 12 12:04:41 node-calculate2 elogind-daemon[2375]: The system will suspend now!
<... NetworkManager ...>
<... dbus-daemon about NetworkManager ...>
Feb 12 12:04:41 node-calculate2 pkexec[12867]: pam_unix(polkit-1:session): session opened for user root(uid=0) by root(uid=1000)
Feb 12 12:04:41 node-calculate2 pkexec[12867]: sasha: Executing command [USER=root] [TTY=unknown] [CWD=/home/sasha] [COMMAND=/usr/sbin/xfpm-power-backlight-helper --set-brightness 937]
<... avahi-daemon, NetworkManager ...>
Feb 12 12:04:46 node-calculate2 elogind-daemon[2375]: Delay lock is active (UID 1001/bob, PID 15244/xfce4-screensav) but inhibitor timeout is reached.
Feb 12 12:04:46 node-calculate2 e-suspend[13018]: Performing sleep operation 'suspend'...
Feb 12 12:04:46 node-calculate2 kernel: PM: suspend entry (deep)
<... kernel ...>
Feb 12 12:05:13 node-calculate2 kernel: ACPI: PM: Low-level resume complete
Feb 12 12:05:13 node-calculate2 elogind-daemon[2375]: Lid opened.
Feb 12 12:05:13 node-calculate2 kernel: ACPI: EC: EC started
<... kernel ...>
<... bluetoothd ...>
Feb 12 12:05:13 node-calculate2 kernel: PM: resume devices took 0.990 seconds
<... kernel ...>
Feb 12 12:05:13 node-calculate2 kernel: random: crng reseeded on system resumption
<... bluetoothd ...>
Feb 12 12:05:13 node-calculate2 root[13025]: ACPI event unhandled: button/lid LID open
<... dbus-daemon about blutoothd and wireplumber ...>
Feb 12 12:05:13 node-calculate2 bluetoothd[12761]: Battery Provider Manager destroyed
Feb 12 12:05:13 node-calculate2 e-suspend[13018]: System returned from sleep operation 'suspend'.
Feb 12 12:05:13 node-calculate2 kernel: PM: suspend exit
<... nothing special, see https://bpa.st/TDMQ ...>
Feb 12 12:05:29 node-calculate2 elogind-daemon[2375]: The system will suspend now!
Feb 12 12:05:29 node-calculate2 NetworkManager[2668]: <info> [1739351129.8245] manager: sleep: sleep requested (sleeping: no enabled: yes)
Feb 12 12:05:29 node-calculate2 NetworkManager[2668]: <info> [1739351129.8250] device (enp2s0): state change: unavailable -> unmanaged (reason 'unmanaged-sleeping', sys-iface-state: 'managed')
Feb 12 12:05:29 node-calculate2 NetworkManager[2668]: <info> [1739351129.8349] device (p2p-dev-wlp3s0): state change: disconnected -> unmanaged (reason 'unmanaged-sleeping', sys-iface-state: 'managed')
Feb 12 12:05:29 node-calculate2 NetworkManager[2668]: <info> [1739351129.8352] manager: NetworkManager state is now ASLEEP
Feb 12 12:05:29 node-calculate2 NetworkManager[2668]: <info> [1739351129.8364] device (wlp3s0): state change: activated -> deactivating (reason 'sleeping', sys-iface-state: 'managed')
Feb 12 12:05:29 node-calculate2 pkexec[13257]: bob: Error executing command as another user: Not authorized [USER=root] [TTY=unknown] [CWD=/home/bob] [COMMAND=/usr/sbin/xfpm-power-backlight-helper --set-brightness 937]
Feb 12 12:05:29 node-calculate2 NetworkManager[2668]: <info> [1739351129.8692] dhcp4 (wlp3s0): canceled DHCP transaction, DHCP client pid 13084
<... ...>
Additional information:
- Re-suspend occurs one time only: there is no re-suspend on wake after re-suspend.
- Turning off the screensaver doesn't help.
- There is nothing in
$HOME/.xfce4-session.verbose-log
, nothing special in$HOME/.xsession-errors
. - The issue happens mostly if two users are logged in. Coincidence? Race conditions? Two timers?
- UPD: On
xfce4-session-logout --suspend
the issue doesn't happen.
Edited by Alexander Kurakin