Bug 489957

Summary:	noisy kwin logs from ei and inputcapture subsystems
Product:	[Plasma] kwin	Reporter:	marchenstar <gardenofglass54>
Component:	wayland-generic	Assignee:	KWin default assignee <kwin-bugs-null>
Status:	RESOLVED FIXED
Severity:	minor	CC:	gardenofglass54
Priority:	NOR
Version:	6.1.2
Target Milestone:	---
Platform:	Arch Linux
OS:	Linux
Latest Commit:	https://invent.kde.org/plasma/kwin/-/commit/5b17454aa5ed0d7eeeef9849a699103ddcd85a6a	Version Fixed In:
Sentry Crash Report:

Description marchenstar 2024-07-09 05:20:41 UTC

SUMMARY
Using input-leap with libei on plasma 6.1 leads to noisy debug logs from kwin libeis and inputcapture subsystems whenever any input is sent to a client machine. This  is captured by the user journal and leads to lot of spam in the journal of both server and client machines

STEPS TO REPRODUCE
1. Install libportal from  HEAD
2. Build input-leap from HEAD with -DQT_DEFAULT_MAJOR_VERSION=6  -DINPUTLEAP_BUILD_LIBEI=ON
3. Configure two machines as server and client with kde plasma 6.1
4. Run journalctl -f on client and server to tail the logs
5. Activate input-leap and move cursor from server to client. Try some input on the client using mouse/keyboard

OBSERVED RESULT
kwin logs spammed in journal from inputcapture subsystem on the server for every input sent to client

kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'
kwin_inputcapture: Libeis: sending: object 0xff00000000000007 (eis_device@v2:frame(11)) signature 'ut'
kwin_inputcapture: Libeis: sending: object 0xff00000000000008 (eis_pointer@v1:motion_relative(1)) signature 'ff'

kwin logs spammed in journal from ei subsystem on the client for every input sent to client. eg.

kwin_libeis: "InputLeap client eis absolute device" pointer motion absolute 1460 490
kwin_libeis: Frame for device "InputLeap client eis absolute device"
kwin_libeis: Libeis: dispatching eis_pointer_absolute.motion_absolute() on object 0xff00000000000004
kwin_libeis: Libeis: queuing pending event type EIS_EVENT_POINTER_MOTION_ABSOLUTE (400)
kwin_libeis: Libeis: dispatching eis_device.frame() on object 0xff00000000000003
kwin_libeis: Libeis: queuing event type EIS_EVENT_FRAME (100)
kwin_libeis: "InputLeap client eis absolute device" pointer motion absolute 1474 488
kwin_libeis: Frame for device "InputLeap client eis absolute device"
kwin_libeis: Libeis: dispatching eis_pointer_absolute.motion_absolute() on object 0xff00000000000004
kwin_libeis: Libeis: queuing pending event type EIS_EVENT_POINTER_MOTION_ABSOLUTE (400)
kwin_libeis: Libeis: dispatching eis_device.frame() on object 0xff00000000000003
kwin_libeis: Libeis: queuing event type EIS_EVENT_FRAME (100)
kwin_libeis: "InputLeap client eis absolute device" pointer motion absolute 1488 488
kwin_libeis: Frame for device "InputLeap client eis absolute device"
kwin_libeis: Libeis: dispatching eis_pointer_absolute.motion_absolute() on object 0xff00000000000004
kwin_libeis: Libeis: queuing pending event type EIS_EVENT_POINTER_MOTION_ABSOLUTE (400)
kwin_libeis: Libeis: dispatching eis_device.frame() on object 0xff00000000000003
kwin_libeis: Libeis: queuing event type EIS_EVENT_FRAME (100)
kwin_libeis: "InputLeap client eis absolute device" pointer motion absolute 1500 486
kwin_libeis: Frame for device "InputLeap client eis absolute device"
kwin_libeis: Libeis: dispatching eis_pointer_absolute.motion_absolute() on object 0xff00000000000004
kwin_libeis: Libeis: queuing pending event type EIS_EVENT_POINTER_MOTION_ABSOLUTE (400)
kwin_libeis: Libeis: dispatching eis_device.frame() on object 0xff00000000000003
kwin_libeis: Libeis: queuing event type EIS_EVENT_FRAME (100)
kwin_libeis: "InputLeap client eis absolute device" pointer motion absolute 1514 484
kwin_libeis: Frame for device "InputLeap client eis absolute device"
kwin_libeis: Libeis: dispatching eis_pointer_absolute.motion_absolute() on object 0xff00000000000004
kwin_libeis: Libeis: queuing pending event type EIS_EVENT_POINTER_MOTION_ABSOLUTE (400)
kwin_libeis: Libeis: dispatching eis_device.frame() on object 0xff00000000000003
kwin_libeis: Libeis: queuing event type EIS_EVENT_FRAME (100)
kwin_libeis: "InputLeap client eis absolute device" pointer motion absolute 1526 484
kwin_libeis: Frame for device "InputLeap client eis absolute device"
kwin_libeis: Libeis: dispatching eis_device.stop_emulating() on object 0xff00000000000007
kwin_libeis: Libeis: queuing event type EIS_EVENT_DEVICE_STOP_EMULATING (201)
kwin_libeis: Libeis: dispatching eis_device.stop_emulating() on object 0xff0000000000000b
kwin_libeis: Libeis: queuing event type EIS_EVENT_DEVICE_STOP_EMULATING (201)
kwin_libeis: Libeis: dispatching eis_device.stop_emulating() on object 0xff00000000000003
kwin_libeis: Libeis: queuing event type EIS_EVENT_DEVICE_STOP_EMULATING (201)
kwin_libeis: Device "InputLeap client eis pointer" stops emulating
kwin_libeis: Device "InputLeap client eis keyboard" stops emulating
kwin_libeis: Device "InputLeap client eis absolute device" stops emulating

EXPECTED RESULT
Debug logs should be  gated behind a verbosity/debug kwin flag/environment and not spam the  journal under regular operation

SOFTWARE/OS VERSIONS
Linux/KDE Plasma: Arch Linux
KDE Plasma Version: 6.1.2
KDE Frameworks Version: 6.3.0
Qt Version: 6.7.2

Comment 1 marchenstar 2024-07-09 06:08:16 UTC

I was able to work around the issue by creating a systemd dropin file for plasma-kwin_wayland.service
[Service]
Environment=QT_LOGGING_RULES="kwin_inputcapture.debug=false;kwin_libeis.debug=false"

Comment 2 Bug Janitor Service 2024-07-12 12:40:04 UTC

A possibly relevant merge request was started @ https://invent.kde.org/plasma/kwin/-/merge_requests/6094

Comment 3 David Edmundson 2024-07-12 12:49:50 UTC

Git commit 5b17454aa5ed0d7eeeef9849a699103ddcd85a6a by David Edmundson.
Committed on 12/07/2024 at 12:39.
Pushed by davidedmundson into branch 'master'.

eis: Change default logging category to warning

This makes it consistent with other debug categories

M  +2    -2    src/plugins/eis/CMakeLists.txt

https://invent.kde.org/plasma/kwin/-/commit/5b17454aa5ed0d7eeeef9849a699103ddcd85a6a