2025-08-25T11:57:38.533233537Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-08-25T11:57:38.648896433Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-08-25T11:57:38.652538823Z s6-rc: info: service fix-attrs: starting
2025-08-25T11:57:38.654405058Z s6-rc: info: service init-migrations: starting
2025-08-25T11:57:38.656175841Z s6-rc: info: service init-envfile: starting
2025-08-25T11:57:38.888224278Z s6-rc: info: service fix-attrs successfully started
2025-08-25T11:57:38.889933869Z s6-rc: info: service legacy-cont-init: starting
2025-08-25T11:57:38.972388260Z [migrations] started
2025-08-25T11:57:38.977405316Z [migrations] no migrations found
2025-08-25T11:57:38.984163856Z s6-rc: info: service init-migrations successfully started
2025-08-25T11:57:38.986012917Z s6-rc: info: service init-adduser: starting
2025-08-25T11:57:39.062722919Z s6-rc: info: service init-envfile successfully started
2025-08-25T11:57:39.117997276Z s6-rc: info: service legacy-cont-init successfully started
2025-08-25T11:57:39.458477439Z usermod: no changes
2025-08-25T11:57:39.493929068Z ───────────────────────────────────────
2025-08-25T11:57:39.493956914Z 
2025-08-25T11:57:39.493962245Z       ██╗     ███████╗██╗ ██████╗
2025-08-25T11:57:39.493967275Z       ██║     ██╔════╝██║██╔═══██╗
2025-08-25T11:57:39.493972325Z       ██║     ███████╗██║██║   ██║
2025-08-25T11:57:39.493977145Z       ██║     ╚════██║██║██║   ██║
2025-08-25T11:57:39.493982045Z       ███████╗███████║██║╚██████╔╝
2025-08-25T11:57:39.493986844Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-08-25T11:57:39.493991684Z 
2025-08-25T11:57:39.493996323Z    Brought to you by linuxserver.io
2025-08-25T11:57:39.494001063Z ───────────────────────────────────────
2025-08-25T11:57:39.504317783Z 
2025-08-25T11:57:39.504485961Z To support LSIO projects visit:
2025-08-25T11:57:39.504502224Z https://www.linuxserver.io/donate/
2025-08-25T11:57:39.504510150Z 
2025-08-25T11:57:39.504685383Z ───────────────────────────────────────
2025-08-25T11:57:39.504695994Z GID/UID
2025-08-25T11:57:39.505018272Z ───────────────────────────────────────
2025-08-25T11:57:39.608342540Z 
2025-08-25T11:57:39.608368843Z User UID:    911
2025-08-25T11:57:39.608385086Z User GID:    911
2025-08-25T11:57:39.608389535Z ───────────────────────────────────────
2025-08-25T11:57:40.275822019Z s6-rc: info: service init-adduser successfully started
2025-08-25T11:57:40.278840012Z s6-rc: info: service init-device-perms: starting
2025-08-25T11:57:40.583656600Z s6-rc: info: service init-device-perms successfully started
2025-08-25T11:57:40.585546373Z s6-rc: info: service init-os-end: starting
2025-08-25T11:57:40.651581544Z s6-rc: info: service init-os-end successfully started
2025-08-25T11:57:40.653584495Z s6-rc: info: service init-selkies: starting
2025-08-25T11:57:40.656265800Z s6-rc: info: service init-crontab-config: starting
2025-08-25T11:57:40.718914858Z s6-rc: info: service init-selkies successfully started
2025-08-25T11:57:40.720777426Z s6-rc: info: service init-nginx: starting
2025-08-25T11:57:40.980628862Z s6-rc: info: service init-crontab-config successfully started
2025-08-25T11:57:41.479484933Z ...+.....+...+...+....+...+..+......+.........+.......+......+..+.+...........+...+.......+...+..+++++++++++++++++++++++++++++++++++++++*..+++++++++++++++++++++++++++++++++++++++*...+.+...+...+.....+.......+........+...................+...+...........+.+...+..+..................+...+...+....+.....+......+.+.........+..+.........+..........+...............+.........+..+...+.+...+..+.+.........+........+...+..........+..+...+....+...+...+..............+......+....+........+......+....+..................+..+......+................+.....+...+.......+..................+........+.........................+.....+...++++++
2025-08-25T11:57:41.730971026Z ..+.+..+...+....+...+............+..+.+........+.........+...+.......+.....+++++++++++++++++++++++++++++++++++++++*.......+++++++++++++++++++++++++++++++++++++++*.............+..+.......+..+...+......+.......+..+.+...........+.+........+.........+.+..............+......+.+.........+.....+....+..+...+.+......+.....+...+.......+...............+......+........+.+......+...+.....+......+...+...+...+......+.+...+.........+........+...................+.........+..+...+....+..+...+.+.....+.+...............+........+...+...............+...+....+......+.................+....+...++++++
2025-08-25T11:57:41.781902384Z -----
2025-08-25T11:57:42.505499791Z s6-rc: info: service init-nginx successfully started
2025-08-25T11:57:42.507329493Z s6-rc: info: service init-selkies-config: starting
2025-08-25T11:57:44.006131347Z s6-rc: info: service init-selkies-config successfully started
2025-08-25T11:57:44.008165650Z s6-rc: info: service init-video: starting
2025-08-25T11:57:44.389567613Z s6-rc: info: service init-video successfully started
2025-08-25T11:57:44.391594161Z s6-rc: info: service init-selkies-end: starting
2025-08-25T11:57:44.460483897Z s6-rc: info: service init-selkies-end successfully started
2025-08-25T11:57:44.463822766Z s6-rc: info: service init-config: starting
2025-08-25T11:57:44.535930558Z s6-rc: info: service init-config successfully started
2025-08-25T11:57:44.538366941Z s6-rc: info: service init-config-end: starting
2025-08-25T11:57:44.598040241Z s6-rc: info: service init-config-end successfully started
2025-08-25T11:57:44.599889402Z s6-rc: info: service init-mods: starting
2025-08-25T11:57:44.657851148Z s6-rc: info: service init-mods successfully started
2025-08-25T11:57:44.660361910Z s6-rc: info: service init-mods-package-install: starting
2025-08-25T11:57:45.027997861Z s6-rc: info: service init-mods-package-install successfully started
2025-08-25T11:57:45.029679095Z s6-rc: info: service init-mods-end: starting
2025-08-25T11:57:45.099033526Z s6-rc: info: service init-mods-end successfully started
2025-08-25T11:57:45.100908769Z s6-rc: info: service init-custom-files: starting
2025-08-25T11:57:45.411620864Z [custom-init] No custom files found, skipping...
2025-08-25T11:57:45.419134033Z s6-rc: info: service init-custom-files successfully started
2025-08-25T11:57:45.422046113Z s6-rc: info: service init-services: starting
2025-08-25T11:57:45.496411608Z s6-rc: info: service init-services successfully started
2025-08-25T11:57:45.498485401Z s6-rc: info: service svc-xorg: starting
2025-08-25T11:57:45.500473111Z s6-rc: info: service svc-pulseaudio: starting
2025-08-25T11:57:45.503051148Z s6-rc: info: service svc-nginx: starting
2025-08-25T11:57:45.505987387Z s6-rc: info: service svc-docker: starting
2025-08-25T11:57:45.507905537Z s6-rc: info: service svc-cron: starting
2025-08-25T11:57:45.569502338Z s6-rc: info: service svc-pulseaudio successfully started
2025-08-25T11:57:45.573000016Z s6-rc: info: service svc-xorg successfully started
2025-08-25T11:57:45.575319513Z s6-rc: info: service svc-dbus: starting
2025-08-25T11:57:45.578071722Z s6-rc: info: service svc-nginx successfully started
2025-08-25T11:57:45.580815092Z s6-rc: info: service svc-xsettingsd: starting
2025-08-25T11:57:45.582860588Z s6-rc: info: service svc-selkies: starting
2025-08-25T11:57:45.584903980Z s6-rc: info: service svc-de: starting
2025-08-25T11:57:45.585203663Z s6-rc: info: service svc-docker successfully started
2025-08-25T11:57:45.585410470Z s6-rc: info: service svc-cron successfully started
2025-08-25T11:57:45.635957886Z s6-rc: info: service svc-selkies successfully started
2025-08-25T11:57:45.637931668Z s6-rc: info: service svc-de successfully started
2025-08-25T11:57:45.645954342Z s6-rc: info: service svc-xsettingsd successfully started
2025-08-25T11:57:45.647979547Z s6-rc: info: service svc-dbus successfully started
2025-08-25T11:57:45.649794660Z s6-rc: info: service legacy-services: starting
2025-08-25T11:57:45.937207639Z s6-rc: info: service legacy-services successfully started
2025-08-25T11:57:45.938820735Z s6-rc: info: service ci-service-check: starting
2025-08-25T11:57:45.946678908Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-08-25T11:57:45.957996813Z screen 0 shmid 0
2025-08-25T11:57:46.014820659Z [ls.io-init] done.
2025-08-25T11:57:46.020272179Z s6-rc: info: service ci-service-check successfully started
2025-08-25T11:57:46.069616996Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-08-25T11:57:47.365876073Z xsettingsd: Created window 0x200001 on screen 0 with timestamp 2324586754
2025-08-25T11:57:47.367187703Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-08-25T11:57:47.367429479Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-08-25T11:57:47.716703422Z 17
2025-08-25T11:57:47.988754140Z 18
2025-08-25T11:57:48.964501105Z sudo: effective uid is not 0, is /usr/bin/sudo on a file system with the 'nosuid' option set or an NFS file system without root privileges?
2025-08-25T11:57:49.588936547Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-08-25T11:57:50.230614857Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-08-25T11:57:50.853197823Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-08-25T11:57:51.507073570Z INFO:main:Upload directory ensured: /config/Desktop
2025-08-25T11:57:51.528225274Z INFO:main:Starting Selkies (WebSocket Mode) with args: Namespace(encoder='x264enc', framerate=60, video_bitrate=16000, dri_node='', audio_device_name='', h264_crf=25, h264_fullcolor=False, h264_streaming_mode=False, watermark_path='', watermark_location=-1, port=8082, debug=False)
2025-08-25T11:57:51.528700821Z INFO:main:Initial Encoder: x264enc, Framerate: 60, Bitrate: 16000kbps
2025-08-25T11:57:51.529138562Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-08-25T11:57:51.530429800Z INFO:main:All main components initialized. Running server...
2025-08-25T11:57:51.567597754Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-08-25T11:57:51.597070071Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-08-25T11:57:51.612216900Z INFO:webrtc_input:Starting clipboard monitor
2025-08-25T11:57:51.630469139Z INFO:webrtc_input:Found XFIXES version 4.0
2025-08-25T11:57:51.630818482Z INFO:webrtc_input:starting cursor monitor
2025-08-25T11:57:51.631297617Z INFO:webrtc_input:watching for cursor changes
2025-08-25T11:57:51.736387540Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-25T11:57:51.746357984Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-08-25T11:57:52.482676271Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-08-25T11:57:52.488066187Z INFO:root:Packed js_config payload for 'Microsoft X-Box 360 pad' (js0): len=1360 bytes. Name='Microsoft X-Box 360 pad', Vendor=0x045e, Product=0x028e, Version=0x0100, Reported Buttons=11 (Array capacity: 512), Reported Axes=8 (Array capacity: 64)
2025-08-25T11:57:52.488455410Z INFO:selkies_gamepad:Gamepad configured. JS socket: /tmp/selkies_js0.sock, EVDEV socket: /tmp/selkies_event1000.sock. Using fixed config: Microsoft X-Box 360 pad
2025-08-25T11:57:52.488936218Z INFO:webrtc_input:Initialized and started persistent gamepad instance for index 0 (Name: 'Microsoft X-Box 360 pad', JS: /tmp/selkies_js0.sock, EVDEV: /tmp/selkies_event1000.sock).
2025-08-25T11:57:52.490227436Z INFO:root:Packed js_config payload for 'Microsoft X-Box 360 pad' (js1): len=1360 bytes. Name='Microsoft X-Box 360 pad', Vendor=0x045e, Product=0x028e, Version=0x0100, Reported Buttons=11 (Array capacity: 512), Reported Axes=8 (Array capacity: 64)
2025-08-25T11:57:52.490616880Z INFO:selkies_gamepad:Gamepad configured. JS socket: /tmp/selkies_js1.sock, EVDEV socket: /tmp/selkies_event1001.sock. Using fixed config: Microsoft X-Box 360 pad
2025-08-25T11:57:52.491068709Z INFO:webrtc_input:Initialized and started persistent gamepad instance for index 1 (Name: 'Microsoft X-Box 360 pad', JS: /tmp/selkies_js1.sock, EVDEV: /tmp/selkies_event1001.sock).
2025-08-25T11:57:52.492108000Z INFO:root:Packed js_config payload for 'Microsoft X-Box 360 pad' (js2): len=1360 bytes. Name='Microsoft X-Box 360 pad', Vendor=0x045e, Product=0x028e, Version=0x0100, Reported Buttons=11 (Array capacity: 512), Reported Axes=8 (Array capacity: 64)
2025-08-25T11:57:52.492479849Z INFO:selkies_gamepad:Gamepad configured. JS socket: /tmp/selkies_js2.sock, EVDEV socket: /tmp/selkies_event1002.sock. Using fixed config: Microsoft X-Box 360 pad
2025-08-25T11:57:52.492931628Z INFO:webrtc_input:Initialized and started persistent gamepad instance for index 2 (Name: 'Microsoft X-Box 360 pad', JS: /tmp/selkies_js2.sock, EVDEV: /tmp/selkies_event1002.sock).
2025-08-25T11:57:52.493968194Z INFO:root:Packed js_config payload for 'Microsoft X-Box 360 pad' (js3): len=1360 bytes. Name='Microsoft X-Box 360 pad', Vendor=0x045e, Product=0x028e, Version=0x0100, Reported Buttons=11 (Array capacity: 512), Reported Axes=8 (Array capacity: 64)
2025-08-25T11:57:52.494329731Z INFO:selkies_gamepad:Gamepad configured. JS socket: /tmp/selkies_js3.sock, EVDEV socket: /tmp/selkies_event1003.sock. Using fixed config: Microsoft X-Box 360 pad
2025-08-25T11:57:52.494765328Z INFO:webrtc_input:Initialized and started persistent gamepad instance for index 3 (Name: 'Microsoft X-Box 360 pad', JS: /tmp/selkies_js3.sock, EVDEV: /tmp/selkies_event1003.sock).
2025-08-25T11:57:52.498243417Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-08-25T11:57:52.498666578Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-08-25T11:57:52.499299352Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-08-25T11:57:52.499643023Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-08-25T11:57:52.500322000Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-08-25T11:57:52.500634268Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-08-25T11:57:52.501253554Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-08-25T11:57:52.501573348Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-08-25T11:57:52.502473329Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-08-25T11:57:52.502910679Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-08-25T11:57:52.503268479Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-08-25T11:57:52.503604104Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-08-25T11:57:52.754405664Z WARNING:webrtc_input:exception from fetching cursor image on change: <class 'Xlib.error.BadAccess'>: code = 10, resource_id = 543, sequence_number = 20, major_opcode = 138, minor_opcode = 4
2025-08-25T11:57:54.881943668Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-25T11:57:59.183003332Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.10' (uid=911 pid=1729 comm="/qemu/qemu-aarch64 /usr/bin/kded6") (using servicehelper)
2025-08-25T11:57:59.204594741Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:57:59.237598144Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.10' (uid=911 pid=1729 comm="/qemu/qemu-aarch64 /usr/bin/kded6") (using servicehelper)
2025-08-25T11:57:59.253150420Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:57:59.259033629Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.10' (uid=911 pid=1729 comm="/qemu/qemu-aarch64 /usr/bin/kded6") (using servicehelper)
2025-08-25T11:57:59.276658756Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:15.134258795Z xsettingsd: Reloading configuration
2025-08-25T11:58:15.134616666Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-08-25T11:58:18.374005532Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:18.390171122Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:23.362573046Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-25T11:58:25.416141085Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.434999524Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.440882233Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.460863292Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.465185870Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.484357230Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.488446730Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.507037431Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.510579659Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.529472799Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.534447079Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.551582041Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.555753004Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.574424839Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.579663261Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.597736540Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.602749107Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.620790764Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:25.625491994Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:25.642883392Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.153692081Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.173557618Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.200604657Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.218219405Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.223454530Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.242063539Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.245635016Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.263775381Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.267472491Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.285026176Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.289382974Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.308741791Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.313029780Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.330607944Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.339039021Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.359035711Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.447979120Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.468028738Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.473148370Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.491668240Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.496542478Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.512392635Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.517459682Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.538878875Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.544145334Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.561811986Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.566676415Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.584979317Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.589154870Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.609416244Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.614363930Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.633546664Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.680076399Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.699878629Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.704678809Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.723590827Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.727757322Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.743371213Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.747395141Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.764578861Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.769262376Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.790813335Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.796006235Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.814032330Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.817678408Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.835653561Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:40.840768163Z dbus-daemon[840]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.13' (uid=911 pid=2356 comm="/qemu/qemu-aarch64 /usr/bin/plasmashell") (using servicehelper)
2025-08-25T11:58:40.859405118Z dbus-daemon[840]: [system] Activated service 'org.freedesktop.UDisks2' failed: Failed to execute program org.freedesktop.UDisks2: Permission denied
2025-08-25T11:58:47.244559838Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-25T12:07:45.241572380Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 32934)
2025-08-25T12:07:45.248287347Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1024, "height": 768}
2025-08-25T12:07:45.249810262Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 32934)
2025-08-25T12:07:45.273226306Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-08-25T12:07:45.338070743Z INFO:data_websocket:PulseAudio connection established.
2025-08-25T12:07:45.348199702Z INFO:data_websocket:Applying client settings (initial=True): {'videoBitRate': 8000, 'videoFramerate': 60, 'videoCRF': 25, 'encoder': 'x264enc', 'h264_fullcolor': False, 'h264_streaming_mode': False, 'resizeRemote': True, 'isManualResolutionMode': False, 'manualWidth': 1024, 'manualHeight': 768, 'audioBitRate': 320000, 'videoBufferSize': 0, 'initialClientWidth': 1920, 'initialClientHeight': 992, 'jpeg_quality': 60, 'paint_over_jpeg_quality': 90, 'use_cpu': False, 'h264_paintover_crf': 18, 'h264_paintover_burst_frames': 5, 'use_paint_over_quality': True, 'scaling_dpi': 96}
2025-08-25T12:07:45.348454875Z INFO:gst_app_resize:on_resize_handler attempting resize for: 1920x992
2025-08-25T12:07:45.348680289Z INFO:gst_app_resize:App dimensions updated to 1920x992 before xrandr call.
2025-08-25T12:07:45.436438558Z INFO:gst_app_resize:Mode 1920x992 not found in xrandr list. Attempting to add for screen 'screen'.
2025-08-25T12:07:45.574560145Z INFO:gst_app_resize:Successfully ran: xrandr --newmode 1920x992 158.00 1920 2040 2240 2560 992 995 1005 1029 -hsync +vsync
2025-08-25T12:07:45.654160815Z INFO:gst_app_resize:Successfully ran: xrandr --addmode screen 1920x992
2025-08-25T12:07:45.654475398Z INFO:gst_app_resize:Applying xrandr mode '1920x992' for screen 'screen'.
2025-08-25T12:07:45.733245936Z INFO:gst_app_resize:Successfully applied xrandr mode '1920x992'.
2025-08-25T12:07:45.734031247Z INFO:gst_app_resize:resize_display('1920x992') reported success.
2025-08-25T12:07:45.734869504Z INFO:data_websocket:Applying SCALING_DPI from initial settings: 96
2025-08-25T12:07:45.736671191Z INFO:gst_app_resize:KDE detected. Applying xrdb for DPI 96.
2025-08-25T12:07:45.739686310Z INFO:gst_app_resize:Wrote 'Xft.dpi:   96' to /config/.Xresources.
2025-08-25T12:07:45.759325122Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-08-25T12:07:46.197937941Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-08-25T12:07:46.199549636Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-08-25T12:07:46.314603338Z INFO:gst_app_resize:Found xsettingsd process with PID: 838.
2025-08-25T12:07:46.375122989Z xsettingsd: Reloading configuration
2025-08-25T12:07:46.376860436Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-08-25T12:07:46.379776436Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 838 to reload config.
2025-08-25T12:07:46.380248306Z INFO:data_websocket:Successfully set DPI to 96 from initial settings.
2025-08-25T12:07:46.380648101Z INFO:data_websocket:Attempting to set cursor size to 32 based on initial DPI.
2025-08-25T12:07:46.992003897Z INFO:data_websocket:Successfully set cursor size to 32.
2025-08-25T12:07:46.992426729Z WARNING:data_websocket:Pipeline is inactive for the initial client. Forcing a start.
2025-08-25T12:07:46.993332171Z INFO:data_websocket:Video pipeline for x264enc needs to start (was not active or forced).
2025-08-25T12:07:46.993856747Z INFO:data_websocket:Starting x264enc: 1920x992 @ 60.0fps, CRF: 25, FullFrame: True
2025-08-25T12:07:47.025038333Z WARNING:data_websocket:Attempting to start backpressure task, but client_settings_received event is not set or None. The task will wait for this event. Ensure it's set when initial client settings are processed.
2025-08-25T12:07:47.025335161Z INFO:data_websocket:Trying to ensure client_settings_received is set for backpressure task start.
2025-08-25T12:07:47.025747791Z INFO:data_websocket:New frame backpressure task started (current encoder: 'x264enc').
2025-08-25T12:07:47.026055681Z INFO:data_websocket:x264enc capture started successfully.
2025-08-25T12:07:47.026662873Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-08-25T12:07:47.027057227Z INFO:data_websocket:Initial setup: Audio pipeline not yet active, attempting start.
2025-08-25T12:07:47.027358083Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-08-25T12:07:47.028146981Z INFO:data_websocket:pcmflux settings: device='', bitrate=320000, channels=2
2025-08-25T12:07:47.030883709Z INFO:data_websocket:Frame-based backpressure logic task started.
2025-08-25T12:07:47.031181970Z INFO:data_websocket:Client settings received, proceeding with backpressure loop.
2025-08-25T12:07:47.037849591Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-08-25T12:07:47.045829664Z [pcmflux] Attempting to connect to PulseAudio device: system_default...
2025-08-25T12:07:47.054805291Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-08-25T12:07:47.068790202Z X Shared Memory Extension available.
2025-08-25T12:07:47.071221827Z XShm setup complete for 1920x992.
2025-08-25T12:07:47.072945236Z CPU cores available: 64
2025-08-25T12:07:47.114241331Z WARNING:webrtc_input:No clipboard content to send
2025-08-25T12:07:47.115086883Z INFO:data_websocket:Received START_VIDEO for encoder: x264enc
2025-08-25T12:07:47.115571879Z INFO:data_websocket:x264enc pipeline is already capturing.
2025-08-25T12:07:47.116988701Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-08-25T12:07:47.117577867Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-08-25T12:07:47.175240708Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-08-25T12:07:47.181572513Z [pcmflux] SUCCESS: Opus encoder created.
2025-08-25T12:07:47.182658809Z [pcmflux] Capture loop started. Device: system_default, Rate: 48000, Channels: 2, Bitrate: 320 kbps, VBR: On, Silence Gate: Off, PCM Chunk: 3840 bytes
2025-08-25T12:07:48.344624417Z INFO:data_websocket:Frame-based backpressure logic task finished.
2025-08-25T12:07:48.345516964Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 2.00 EncStripes/s: 2.00
2025-08-25T12:07:49.151472925Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-08-25T12:07:49.186161139Z [pcmflux] Status | Read: 1, Silent: 0 (0.0%), Encoded: 1, Rate: 0.01 kbps
2025-08-25T12:07:49.454010367Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 4.00 EncStripes/s: 4.00
2025-08-25T12:07:50.528871532Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 2.00 EncStripes/s: 2.00
2025-08-25T12:07:51.238248899Z [pcmflux] Status | Read: 17, Silent: 0 (0.0%), Encoded: 17, Rate: 0.20 kbps
2025-08-25T12:07:51.549209517Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 4.00 EncStripes/s: 4.00
2025-08-25T12:07:52.556596193Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-25T12:07:53.240418050Z [pcmflux] Status | Read: 134, Silent: 0 (0.0%), Encoded: 134, Rate: 1.61 kbps
2025-08-25T12:07:53.573796613Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-25T12:07:54.585674911Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-25T12:07:55.241472448Z [pcmflux] Status | Read: 98, Silent: 0 (0.0%), Encoded: 98, Rate: 1.18 kbps
2025-08-25T12:07:55.593227873Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-25T12:07:55.736909162Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 32934)...
2025-08-25T12:07:55.743530009Z INFO:data_websocket:No other clients in set after ('127.0.0.1', 32934) disconnected. Marking pipelines for stop.
2025-08-25T12:07:55.743937590Z INFO:data_websocket:Stopping global pipelines due to last client disconnect (('127.0.0.1', 32934)).
2025-08-25T12:07:55.744178935Z INFO:main:Initiating unified pipeline shutdown...
2025-08-25T12:07:55.755637140Z INFO:main:Queueing x264-striped capture stop.
2025-08-25T12:07:55.756135373Z INFO:main:Queueing pcmflux audio capture stop.
2025-08-25T12:07:55.759489745Z INFO:main:Waiting for 2 capture module(s) to stop...
2025-08-25T12:07:55.766459605Z Capture loop stopped. X resources released.