2025-08-30T22:48:03.063670783Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-08-30T22:48:03.063714992Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-08-30T22:48:04.110858587Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-08-30T22:48:04.236545713Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-08-30T22:48:04.239657559Z s6-rc: info: service fix-attrs: starting
2025-08-30T22:48:04.242165258Z s6-rc: info: service init-migrations: starting
2025-08-30T22:48:04.244076587Z s6-rc: info: service init-envfile: starting
2025-08-30T22:48:04.478805012Z s6-rc: info: service fix-attrs successfully started
2025-08-30T22:48:04.480638604Z s6-rc: info: service legacy-cont-init: starting
2025-08-30T22:48:04.574588496Z [migrations] started
2025-08-30T22:48:04.579568163Z [migrations] no migrations found
2025-08-30T22:48:04.585999121Z s6-rc: info: service init-migrations successfully started
2025-08-30T22:48:04.589013832Z s6-rc: info: service init-adduser: starting
2025-08-30T22:48:04.639299414Z s6-rc: info: service init-envfile successfully started
2025-08-30T22:48:04.699253474Z s6-rc: info: service legacy-cont-init successfully started
2025-08-30T22:48:05.237632310Z usermod: no changes
2025-08-30T22:48:05.388242620Z ───────────────────────────────────────
2025-08-30T22:48:05.388280377Z 
2025-08-30T22:48:05.388289495Z       ██╗     ███████╗██╗ ██████╗
2025-08-30T22:48:05.388298172Z       ██║     ██╔════╝██║██╔═══██╗
2025-08-30T22:48:05.388306609Z       ██║     ███████╗██║██║   ██║
2025-08-30T22:48:05.388315066Z       ██║     ╚════██║██║██║   ██║
2025-08-30T22:48:05.388323463Z       ███████╗███████║██║╚██████╔╝
2025-08-30T22:48:05.388331920Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-08-30T22:48:05.388340357Z 
2025-08-30T22:48:05.388348363Z    Brought to you by linuxserver.io
2025-08-30T22:48:05.388356850Z ───────────────────────────────────────
2025-08-30T22:48:05.397269075Z 
2025-08-30T22:48:05.397511944Z To support LSIO projects visit:
2025-08-30T22:48:05.397533007Z https://www.linuxserver.io/donate/
2025-08-30T22:48:05.397541394Z 
2025-08-30T22:48:05.397788842Z ───────────────────────────────────────
2025-08-30T22:48:05.397800836Z GID/UID
2025-08-30T22:48:05.398357457Z ───────────────────────────────────────
2025-08-30T22:48:05.530569451Z 
2025-08-30T22:48:05.530609171Z User UID:    911
2025-08-30T22:48:05.530618470Z User GID:    911
2025-08-30T22:48:05.530627177Z ───────────────────────────────────────
2025-08-30T22:48:06.236090746Z s6-rc: info: service init-adduser successfully started
2025-08-30T22:48:06.239358886Z s6-rc: info: service init-device-perms: starting
2025-08-30T22:48:06.555958732Z s6-rc: info: service init-device-perms successfully started
2025-08-30T22:48:06.558413766Z s6-rc: info: service init-os-end: starting
2025-08-30T22:48:06.633768536Z s6-rc: info: service init-os-end successfully started
2025-08-30T22:48:06.636806883Z s6-rc: info: service init-selkies: starting
2025-08-30T22:48:06.715732233Z s6-rc: info: service init-selkies successfully started
2025-08-30T22:48:06.718397459Z s6-rc: info: service init-nginx: starting
2025-08-30T22:48:07.711776277Z .....+..+.......+......+........+......+....+++++++++++++++++++++++++++++++++++++++*..+...+.........+......+.+......+........+.......+..+...+....+.........+..+++++++++++++++++++++++++++++++++++++++*.....................+..+...+......+.+......+............+...+...+.....+.+.........+.....+......+.+............+..+.+...+.........+..+....+..+.........+...+.............+.........+...+..+.........+.+......+...+..+...+.........+...+...+..........+..+.......+.....+...+.........+.............+......+..........................+.+..+......+......................+...+.....+....+............+...+..+......+..........+..+...+...+.......+...+.....+......+....+......+.....+.+..................+..+...+......+.............+...........+.........+.+......+.....+.+.................+.+.................+..................+....+.....+...+....+...+..+...+.+.....+...............+.+.....+...+............+.+...+...........+.+..+.......+.....+....+...............+..+.......+......+..+....+...+...+...+.....+.+.....+...+...............+...+....+...+..+.+..+.......+.....+.+.....+...+....++++++
2025-08-30T22:48:08.102518632Z ..+...+..+...+....+.....+...+.+..+..........+.....+...+.+++++++++++++++++++++++++++++++++++++++*......+....+++++++++++++++++++++++++++++++++++++++*...+....+.....+.+..+.........+...+.+..............+......+......+....+...........+.+.........+...+.....+...+...+....+...+............+........+.............+..+...+....+...+.....+.........+................+...+..+...+...............+......+......+...................+...+.....+.+.........+.....+..........+.....+............+.+.....+..........+.........+...+........+...+......+.+...+..+.......+..+....+..+.............+...........+...+............+.+............+........+...+..........+.........+...+.................+...+.......+.....+......+....+...+..+......+.+......+.....+...+.+......+..+............+.+...+...........+.+..+.......+...............+...+........+...+....+............+........+.......+......+..+...+.......+........+..........+............+..+.........++++++
2025-08-30T22:48:08.149502345Z -----
2025-08-30T22:48:08.917264675Z s6-rc: info: service init-nginx successfully started
2025-08-30T22:48:08.919542702Z s6-rc: info: service init-selkies-config: starting
2025-08-30T22:48:10.439585408Z s6-rc: info: service init-selkies-config successfully started
2025-08-30T22:48:10.442835933Z s6-rc: info: service init-video: starting
2025-08-30T22:48:10.866866194Z s6-rc: info: service init-video successfully started
2025-08-30T22:48:10.869850994Z s6-rc: info: service init-selkies-end: starting
2025-08-30T22:48:10.950423571Z s6-rc: info: service init-selkies-end successfully started
2025-08-30T22:48:10.952431343Z s6-rc: info: service init-config: starting
2025-08-30T22:48:11.021900502Z s6-rc: info: service init-config successfully started
2025-08-30T22:48:11.025157791Z s6-rc: info: service init-crontab-config: starting
2025-08-30T22:48:11.363220884Z s6-rc: info: service init-crontab-config successfully started
2025-08-30T22:48:11.366241155Z s6-rc: info: service init-config-end: starting
2025-08-30T22:48:11.428871815Z s6-rc: info: service init-config-end successfully started
2025-08-30T22:48:11.431217247Z s6-rc: info: service init-mods: starting
2025-08-30T22:48:11.503310210Z s6-rc: info: service init-mods successfully started
2025-08-30T22:48:11.506205449Z s6-rc: info: service init-mods-package-install: starting
2025-08-30T22:48:11.836827079Z s6-rc: info: service init-mods-package-install successfully started
2025-08-30T22:48:11.839324918Z s6-rc: info: service init-mods-end: starting
2025-08-30T22:48:11.913460954Z s6-rc: info: service init-mods-end successfully started
2025-08-30T22:48:11.916006399Z s6-rc: info: service init-custom-files: starting
2025-08-30T22:48:12.233261535Z [custom-init] No custom files found, skipping...
2025-08-30T22:48:12.241918646Z s6-rc: info: service init-custom-files successfully started
2025-08-30T22:48:12.245045132Z s6-rc: info: service init-services: starting
2025-08-30T22:48:12.325190648Z s6-rc: info: service init-services successfully started
2025-08-30T22:48:12.333917871Z s6-rc: info: service svc-xorg: starting
2025-08-30T22:48:12.337187775Z s6-rc: info: service svc-pulseaudio: starting
2025-08-30T22:48:12.339412675Z s6-rc: info: service svc-nginx: starting
2025-08-30T22:48:12.342236310Z s6-rc: info: service svc-docker: starting
2025-08-30T22:48:12.345326372Z s6-rc: info: service svc-cron: starting
2025-08-30T22:48:12.408442880Z s6-rc: info: service svc-nginx successfully started
2025-08-30T22:48:12.408707503Z s6-rc: info: service svc-xorg successfully started
2025-08-30T22:48:12.411168879Z s6-rc: info: service svc-xsettingsd: starting
2025-08-30T22:48:12.413596577Z s6-rc: info: service svc-de: starting
2025-08-30T22:48:12.416654244Z s6-rc: info: service svc-dbus: starting
2025-08-30T22:48:12.416955350Z s6-rc: info: service svc-pulseaudio successfully started
2025-08-30T22:48:12.417189712Z s6-rc: info: service svc-docker successfully started
2025-08-30T22:48:12.417467331Z s6-rc: info: service svc-cron successfully started
2025-08-30T22:48:12.482702143Z s6-rc: info: service svc-de successfully started
2025-08-30T22:48:12.483372794Z s6-rc: info: service svc-xsettingsd successfully started
2025-08-30T22:48:12.499385185Z s6-rc: info: service svc-dbus successfully started
2025-08-30T22:48:12.502299554Z s6-rc: info: service svc-selkies: starting
2025-08-30T22:48:12.571931501Z s6-rc: info: service svc-selkies successfully started
2025-08-30T22:48:12.575500026Z s6-rc: info: service legacy-services: starting
2025-08-30T22:48:12.823445484Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-08-30T22:48:12.834540614Z screen 0 shmid 0
2025-08-30T22:48:12.883474525Z s6-rc: info: service legacy-services successfully started
2025-08-30T22:48:12.885262224Z s6-rc: info: service ci-service-check: starting
2025-08-30T22:48:12.907616445Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-08-30T22:48:12.981491726Z [ls.io-init] done.
2025-08-30T22:48:12.987505936Z s6-rc: info: service ci-service-check successfully started
2025-08-30T22:48:14.262904942Z xsettingsd: Created window 0x200001 on screen 0 with timestamp 2795613652
2025-08-30T22:48:14.264159939Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-08-30T22:48:14.264379882Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-08-30T22:48:14.582532294Z 17
2025-08-30T22:48:14.897695367Z 18
2025-08-30T22:48:16.481593689Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-08-30T22:48:17.034133640Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-08-30T22:48:17.644648065Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-08-30T22:48:18.289206208Z INFO:main:Upload directory ensured: /config/Desktop
2025-08-30T22:48:18.306660262Z INFO:main:Starting Selkies (WebSocket Mode) with args: Namespace(encoder='x264enc', framerate=60, video_bitrate=16000, dri_node='', audio_device_name='output.monitor', h264_crf=25, h264_fullcolor=False, h264_streaming_mode=False, watermark_path='', watermark_location=-1, port=8082, debug=False)
2025-08-30T22:48:18.307094035Z INFO:main:Initial Encoder: x264enc, Framerate: 60, Bitrate: 16000kbps
2025-08-30T22:48:18.307468620Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-08-30T22:48:18.308584356Z INFO:main:All main components initialized. Running server...
2025-08-30T22:48:18.344414622Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-08-30T22:48:18.374924054Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-08-30T22:48:18.392615146Z INFO:webrtc_input:Starting clipboard monitor
2025-08-30T22:48:18.409544754Z INFO:webrtc_input:Found XFIXES version 4.0
2025-08-30T22:48:18.409788826Z INFO:webrtc_input:starting cursor monitor
2025-08-30T22:48:18.410268211Z INFO:webrtc_input:watching for cursor changes
2025-08-30T22:48:18.494565126Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-30T22:48:18.504399508Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-08-30T22:48:19.263630950Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-08-30T22:48:19.266990044Z 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-30T22:48:19.267267573Z 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-30T22:48:19.267579702Z 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-30T22:48:19.269959443Z 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-30T22:48:19.270174426Z 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-30T22:48:19.270467747Z 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-30T22:48:19.271106132Z 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-30T22:48:19.271340935Z 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-30T22:48:19.271600998Z 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-30T22:48:19.272238883Z 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-30T22:48:19.272482273Z 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-30T22:48:19.272830274Z 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-30T22:48:19.275517344Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-08-30T22:48:19.276018182Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-08-30T22:48:19.276687661Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-08-30T22:48:19.277063708Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-08-30T22:48:19.277656632Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-08-30T22:48:19.277939131Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-08-30T22:48:19.278582466Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-08-30T22:48:19.278897019Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-08-30T22:48:19.279869488Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-08-30T22:48:19.280288131Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-08-30T22:48:19.280659428Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-08-30T22:48:19.280986216Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-08-30T22:48:23.308058715Z dbus-daemon[852]: [system] Activating service name='org.freedesktop.hostname1' requested by ':1.11' (uid=911 pid=1551 comm="/qemu/qemu-aarch64 /usr/libexec/mate-settings-daem") (using servicehelper)
2025-08-30T22:48:23.330218564Z dbus-daemon[852]: [system] Activated service 'org.freedesktop.hostname1' failed: Failed to execute program org.freedesktop.hostname1: Permission denied
2025-08-30T22:48:23.700694983Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-30T22:48:26.655961429Z dbus-daemon[852]: [system] Activating service name='org.freedesktop.PolicyKit1' requested by ':1.13' (uid=911 pid=1629 comm="/qemu/qemu-aarch64 /usr/libexec/polkit-mate-authen") (using servicehelper)
2025-08-30T22:48:26.677002916Z dbus-daemon[852]: [system] Activated service 'org.freedesktop.PolicyKit1' failed: Failed to execute program org.freedesktop.PolicyKit1: Permission denied
2025-08-30T22:48:28.736815159Z dbus-daemon[852]: [system] Activating service name='org.mate.SettingsDaemon.DateTimeMechanism' requested by ':1.14' (uid=911 pid=1661 comm="/qemu/qemu-aarch64 /usr/libexec/mate-panel/clock-a") (using servicehelper)
2025-08-30T22:48:28.757124443Z dbus-daemon[852]: [system] Activated service 'org.mate.SettingsDaemon.DateTimeMechanism' failed: Failed to execute program org.mate.SettingsDaemon.DateTimeMechanism: Permission denied
2025-08-30T22:48:28.795703112Z dbus-daemon[852]: [system] Activating service name='org.freedesktop.login1' requested by ':1.15' (uid=911 pid=1661 comm="/qemu/qemu-aarch64 /usr/libexec/mate-panel/clock-a") (using servicehelper)
2025-08-30T22:48:28.816385227Z dbus-daemon[852]: [system] Activated service 'org.freedesktop.login1' failed: Failed to execute program org.freedesktop.login1: Permission denied
2025-08-30T22:49:51.484277725Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 56336)
2025-08-30T22:49:51.489897561Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1024, "height": 768}
2025-08-30T22:49:51.491012416Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 56336)
2025-08-30T22:49:51.511122939Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-08-30T22:49:51.587245565Z INFO:data_websocket:PulseAudio connection established.
2025-08-30T22:49:51.597426925Z 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-30T22:49:51.597716268Z INFO:gst_app_resize:on_resize_handler attempting resize for: 1920x992
2025-08-30T22:49:51.597944868Z INFO:gst_app_resize:App dimensions updated to 1920x992 before xrandr call.
2025-08-30T22:49:51.682551397Z INFO:gst_app_resize:Mode 1920x992 not found in xrandr list. Attempting to add for screen 'screen'.
2025-08-30T22:49:51.827550869Z INFO:gst_app_resize:Successfully ran: xrandr --newmode 1920x992 158.00 1920 2040 2240 2560 992 995 1005 1029 -hsync +vsync
2025-08-30T22:49:51.912551511Z INFO:gst_app_resize:Successfully ran: xrandr --addmode screen 1920x992
2025-08-30T22:49:51.912864912Z INFO:gst_app_resize:Applying xrandr mode '1920x992' for screen 'screen'.
2025-08-30T22:49:52.002900142Z INFO:gst_app_resize:Successfully applied xrandr mode '1920x992'.
2025-08-30T22:49:52.004065228Z INFO:gst_app_resize:resize_display('1920x992') reported success.
2025-08-30T22:49:52.005337870Z INFO:data_websocket:Applying SCALING_DPI from initial settings: 96
2025-08-30T22:49:52.011722686Z INFO:gst_app_resize:MATE detected. Applying MATE gsettings and xrdb for DPI 96.
2025-08-30T22:49:52.038335973Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-08-30T22:49:52.425778945Z INFO:gst_app_resize:Successfully set MATE window-scaling-factor to 1 (for DPI 96) using gsettings.
2025-08-30T22:49:52.860990901Z INFO:gst_app_resize:Successfully set MATE font-rendering DPI to 96 using gsettings.
2025-08-30T22:49:52.862752979Z INFO:gst_app_resize:Wrote 'Xft.dpi:   96' to /config/.Xresources.
2025-08-30T22:49:53.311984033Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-08-30T22:49:53.313667082Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-08-30T22:49:53.445612089Z INFO:gst_app_resize:Found xsettingsd process with PID: 845.
2025-08-30T22:49:53.496636177Z xsettingsd: Reloading configuration
2025-08-30T22:49:53.499265001Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-08-30T22:49:53.503038619Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 845 to reload config.
2025-08-30T22:49:53.504400561Z INFO:data_websocket:Successfully set DPI to 96 from initial settings.
2025-08-30T22:49:53.505483973Z INFO:data_websocket:Attempting to set cursor size to 32 based on initial DPI.
2025-08-30T22:49:54.100404599Z INFO:data_websocket:Successfully set cursor size to 32.
2025-08-30T22:49:54.101080480Z WARNING:data_websocket:Pipeline is inactive for the initial client. Forcing a start.
2025-08-30T22:49:54.101566669Z INFO:data_websocket:Video pipeline for x264enc needs to start (was not active or forced).
2025-08-30T22:49:54.103258545Z INFO:data_websocket:Starting x264enc: 1920x992 @ 60.0fps, CRF: 25, FullFrame: True
2025-08-30T22:49:54.140668171Z 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-30T22:49:54.141032044Z INFO:data_websocket:Trying to ensure client_settings_received is set for backpressure task start.
2025-08-30T22:49:54.141553514Z INFO:data_websocket:New frame backpressure task started (current encoder: 'x264enc').
2025-08-30T22:49:54.141925944Z INFO:data_websocket:x264enc capture started successfully.
2025-08-30T22:49:54.142642977Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-08-30T22:49:54.143121581Z INFO:data_websocket:Initial setup: Audio pipeline not yet active, attempting start.
2025-08-30T22:49:54.143486586Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-08-30T22:49:54.144573485Z INFO:data_websocket:pcmflux settings: device='output.monitor', bitrate=320000, channels=2
2025-08-30T22:49:54.149204229Z INFO:data_websocket:Frame-based backpressure logic task started.
2025-08-30T22:49:54.151441263Z INFO:data_websocket:Client settings received, proceeding with backpressure loop.
2025-08-30T22:49:54.155407660Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-08-30T22:49:54.165185849Z [pcmflux] Attempting to connect to PulseAudio device: output.monitor...
2025-08-30T22:49:54.172100973Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-08-30T22:49:54.182534150Z X Shared Memory Extension available.
2025-08-30T22:49:54.184905405Z XShm setup complete for 1920x992.
2025-08-30T22:49:54.186603233Z CPU cores available: 64
2025-08-30T22:49:54.231925872Z WARNING:webrtc_input:No clipboard content to send
2025-08-30T22:49:54.232847478Z INFO:data_websocket:Received START_VIDEO for encoder: x264enc
2025-08-30T22:49:54.233327815Z INFO:data_websocket:x264enc pipeline is already capturing.
2025-08-30T22:49:54.234722163Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-08-30T22:49:54.235292421Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-08-30T22:49:54.286774843Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-08-30T22:49:54.288945664Z [pcmflux] SUCCESS: Opus encoder created.
2025-08-30T22:49:54.290654094Z [pcmflux] Capture loop started. Device: output.monitor, Rate: 48000, Channels: 2, Bitrate: 320 kbps, VBR: On, Silence Gate: Off, PCM Chunk: 3840 bytes
2025-08-30T22:49:54.653772647Z INFO:data_websocket:Frame-based backpressure logic task finished.
2025-08-30T22:49:55.302350234Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 6.00 EncStripes/s: 6.00
2025-08-30T22:49:56.271398070Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-08-30T22:49:56.308787084Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-30T22:49:56.317291688Z [pcmflux] Status | Read: 1, Silent: 0 (0.0%), Encoded: 1, Rate: 0.01 kbps
2025-08-30T22:49:57.325547441Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-30T22:49:58.318398876Z [pcmflux] Status | Read: 28, Silent: 0 (0.0%), Encoded: 28, Rate: 0.34 kbps
2025-08-30T22:49:58.336468991Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-30T22:49:59.342409582Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-30T22:50:00.319916160Z [pcmflux] Status | Read: 111, Silent: 0 (0.0%), Encoded: 111, Rate: 1.33 kbps
2025-08-30T22:50:00.404489782Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 2.00 EncStripes/s: 2.00
2025-08-30T22:50:01.408720701Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 4.00 EncStripes/s: 4.00
2025-08-30T22:50:01.533583767Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 56336)...
2025-08-30T22:50:01.539751797Z INFO:data_websocket:No other clients in set after ('127.0.0.1', 56336) disconnected. Marking pipelines for stop.
2025-08-30T22:50:01.540142784Z INFO:data_websocket:Stopping global pipelines due to last client disconnect (('127.0.0.1', 56336)).
2025-08-30T22:50:01.540406575Z INFO:main:Initiating unified pipeline shutdown...
2025-08-30T22:50:01.551769946Z INFO:main:Queueing x264-striped capture stop.
2025-08-30T22:50:01.552242748Z INFO:main:Queueing pcmflux audio capture stop.
2025-08-30T22:50:01.555798307Z INFO:main:Waiting for 2 capture module(s) to stop...
2025-08-30T22:50:01.568484922Z Capture loop stopped. X resources released.