2025-08-27T13:13:45.539646244Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-08-27T13:13:45.539673048Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-08-27T13:13:46.637813869Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-08-27T13:13:46.738596214Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-08-27T13:13:46.740850284Z s6-rc: info: service fix-attrs: starting
2025-08-27T13:13:46.742732715Z s6-rc: info: service init-migrations: starting
2025-08-27T13:13:46.744551198Z s6-rc: info: service init-envfile: starting
2025-08-27T13:13:46.984042993Z s6-rc: info: service fix-attrs successfully started
2025-08-27T13:13:46.986532818Z s6-rc: info: service legacy-cont-init: starting
2025-08-27T13:13:47.065310416Z [migrations] started
2025-08-27T13:13:47.070978531Z [migrations] no migrations found
2025-08-27T13:13:47.078245256Z s6-rc: info: service init-migrations successfully started
2025-08-27T13:13:47.080478113Z s6-rc: info: service init-adduser: starting
2025-08-27T13:13:47.142041381Z s6-rc: info: service init-envfile successfully started
2025-08-27T13:13:47.219871842Z s6-rc: info: service legacy-cont-init successfully started
2025-08-27T13:13:47.759136769Z usermod: no changes
2025-08-27T13:13:47.941283031Z ───────────────────────────────────────
2025-08-27T13:13:47.941328051Z
2025-08-27T13:13:47.941337290Z ██╗ ███████╗██╗ ██████╗
2025-08-27T13:13:47.941345867Z ██║ ██╔════╝██║██╔═══██╗
2025-08-27T13:13:47.941354384Z ██║ ███████╗██║██║ ██║
2025-08-27T13:13:47.941362551Z ██║ ╚════██║██║██║ ██║
2025-08-27T13:13:47.941370647Z ███████╗███████║██║╚██████╔╝
2025-08-27T13:13:47.941378774Z ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-08-27T13:13:47.941387010Z
2025-08-27T13:13:47.941394866Z Brought to you by linuxserver.io
2025-08-27T13:13:47.941402912Z ───────────────────────────────────────
2025-08-27T13:13:47.954641625Z
2025-08-27T13:13:47.954982792Z To support LSIO projects visit:
2025-08-27T13:13:47.955003073Z https://www.linuxserver.io/donate/
2025-08-27T13:13:47.955012672Z
2025-08-27T13:13:47.955426646Z ───────────────────────────────────────
2025-08-27T13:13:47.955449091Z GID/UID
2025-08-27T13:13:47.956117748Z ───────────────────────────────────────
2025-08-27T13:13:48.070538631Z
2025-08-27T13:13:48.070576046Z User UID: 911
2025-08-27T13:13:48.070585776Z User GID: 911
2025-08-27T13:13:48.070594143Z ───────────────────────────────────────
2025-08-27T13:13:48.115693973Z Linuxserver.io version: 1142.0.1build1-1xtradeb1.2404.1-ls27
2025-08-27T13:13:48.119428084Z Build-date: 2025-08-27T13:04:36+00:00
2025-08-27T13:13:48.119457644Z ───────────────────────────────────────
2025-08-27T13:13:48.119468155Z
2025-08-27T13:13:48.804548012Z s6-rc: info: service init-adduser successfully started
2025-08-27T13:13:48.807661714Z s6-rc: info: service init-device-perms: starting
2025-08-27T13:13:49.166984258Z s6-rc: info: service init-device-perms successfully started
2025-08-27T13:13:49.168909285Z s6-rc: info: service init-os-end: starting
2025-08-27T13:13:49.229051240Z s6-rc: info: service init-os-end successfully started
2025-08-27T13:13:49.231682580Z s6-rc: info: service init-selkies: starting
2025-08-27T13:13:49.301942112Z s6-rc: info: service init-selkies successfully started
2025-08-27T13:13:49.303753971Z s6-rc: info: service init-nginx: starting
2025-08-27T13:13:52.242087812Z ......+.....+..........+.....+....+...+..+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.+.........+...+...............+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*......+.+...........+.+.....+...+.+...+..+.+.....+.........+....+...........+.+.....+....+.....+..................+...+...+....+......+..............+..........+...........+.+......+...+.........+........+....+...+......+.....+.+...+.....+...+...........................+.+..+....+.....+...+...+..................+......+..........+...+.....+......................+......+........+.......+.....+..........+........+....+.....................+.................+....+......+.....+..........+.........+.....+...+.+..+....+......+.........+...+....................+.+..+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2025-08-27T13:13:52.701653495Z .......+.....+.+...............+...........+.+...+.....+......+...+.+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.....+......+.+..............+.+...+..+....+...........+...+............+...+.+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.............+.........+...+.....+...+...+.+...+........+.......+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2025-08-27T13:13:52.754333483Z -----
2025-08-27T13:13:53.534846683Z s6-rc: info: service init-nginx successfully started
2025-08-27T13:13:53.537933690Z s6-rc: info: service init-selkies-config: starting
2025-08-27T13:13:55.008990501Z s6-rc: info: service init-selkies-config successfully started
2025-08-27T13:13:55.012123180Z s6-rc: info: service init-video: starting
2025-08-27T13:13:55.446782843Z s6-rc: info: service init-video successfully started
2025-08-27T13:13:55.449647372Z s6-rc: info: service init-selkies-end: starting
2025-08-27T13:13:55.523916750Z s6-rc: info: service init-selkies-end successfully started
2025-08-27T13:13:55.526667370Z s6-rc: info: service init-config: starting
2025-08-27T13:13:55.601005566Z s6-rc: info: service init-config successfully started
2025-08-27T13:13:55.604228347Z s6-rc: info: service init-crontab-config: starting
2025-08-27T13:13:55.968723769Z s6-rc: info: service init-crontab-config successfully started
2025-08-27T13:13:55.972099548Z s6-rc: info: service init-config-end: starting
2025-08-27T13:13:56.060150903Z s6-rc: info: service init-config-end successfully started
2025-08-27T13:13:56.062601899Z s6-rc: info: service init-mods: starting
2025-08-27T13:13:56.137187183Z s6-rc: info: service init-mods successfully started
2025-08-27T13:13:56.139205498Z s6-rc: info: service init-mods-package-install: starting
2025-08-27T13:13:56.494938964Z s6-rc: info: service init-mods-package-install successfully started
2025-08-27T13:13:56.496942198Z s6-rc: info: service init-mods-end: starting
2025-08-27T13:13:56.596639488Z s6-rc: info: service init-mods-end successfully started
2025-08-27T13:13:56.598931384Z s6-rc: info: service init-custom-files: starting
2025-08-27T13:13:56.923137062Z [custom-init] No custom files found, skipping...
2025-08-27T13:13:56.936443181Z s6-rc: info: service init-custom-files successfully started
2025-08-27T13:13:56.939621081Z s6-rc: info: service init-services: starting
2025-08-27T13:13:57.025985459Z s6-rc: info: service init-services successfully started
2025-08-27T13:13:57.029211877Z s6-rc: info: service svc-xorg: starting
2025-08-27T13:13:57.032120825Z s6-rc: info: service svc-pulseaudio: starting
2025-08-27T13:13:57.035415851Z s6-rc: info: service svc-nginx: starting
2025-08-27T13:13:57.038613982Z s6-rc: info: service svc-docker: starting
2025-08-27T13:13:57.041845190Z s6-rc: info: service svc-cron: starting
2025-08-27T13:13:57.129293811Z s6-rc: info: service svc-nginx successfully started
2025-08-27T13:13:57.134181234Z s6-rc: info: service svc-docker successfully started
2025-08-27T13:13:57.136738224Z s6-rc: info: service svc-cron successfully started
2025-08-27T13:13:57.148977574Z s6-rc: info: service svc-xorg successfully started
2025-08-27T13:13:57.151896092Z s6-rc: info: service svc-xsettingsd: starting
2025-08-27T13:13:57.154437931Z s6-rc: info: service svc-dbus: starting
2025-08-27T13:13:57.155050645Z s6-rc: info: service svc-pulseaudio successfully started
2025-08-27T13:13:57.157486651Z s6-rc: info: service svc-selkies: starting
2025-08-27T13:13:57.254839059Z s6-rc: info: service svc-dbus successfully started
2025-08-27T13:13:57.279597552Z s6-rc: info: service svc-selkies successfully started
2025-08-27T13:13:57.281826832Z s6-rc: info: service svc-de: starting
2025-08-27T13:13:57.285440510Z s6-rc: info: service svc-xsettingsd successfully started
2025-08-27T13:13:57.399896634Z s6-rc: info: service svc-de successfully started
2025-08-27T13:13:57.401808164Z s6-rc: info: service legacy-services: starting
2025-08-27T13:13:57.540106817Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-08-27T13:13:57.552014970Z screen 0 shmid 0
2025-08-27T13:13:57.626955099Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-08-27T13:13:57.710675601Z s6-rc: info: service legacy-services successfully started
2025-08-27T13:13:57.712539765Z s6-rc: info: service ci-service-check: starting
2025-08-27T13:13:57.803223011Z [ls.io-init] done.
2025-08-27T13:13:57.818861587Z s6-rc: info: service ci-service-check successfully started
2025-08-27T13:13:58.809015842Z The XKEYBOARD keymap compiler (xkbcomp) reports:
2025-08-27T13:13:58.809573776Z > Warning: Could not resolve keysym XF86CameraAccessEnable
2025-08-27T13:13:58.809804992Z > Warning: Could not resolve keysym XF86CameraAccessDisable
2025-08-27T13:13:58.809835754Z > Warning: Could not resolve keysym XF86CameraAccessToggle
2025-08-27T13:13:58.810075978Z > Warning: Could not resolve keysym XF86NextElement
2025-08-27T13:13:58.810118954Z > Warning: Could not resolve keysym XF86PreviousElement
2025-08-27T13:13:58.810130898Z > Warning: Could not resolve keysym XF86AutopilotEngageToggle
2025-08-27T13:13:58.810141249Z > Warning: Could not resolve keysym XF86MarkWaypoint
2025-08-27T13:13:58.810150979Z > Warning: Could not resolve keysym XF86Sos
2025-08-27T13:13:58.810159716Z > Warning: Could not resolve keysym XF86NavChart
2025-08-27T13:13:58.810172783Z > Warning: Could not resolve keysym XF86FishingChart
2025-08-27T13:13:58.810181430Z > Warning: Could not resolve keysym XF86SingleRangeRadar
2025-08-27T13:13:58.810189937Z > Warning: Could not resolve keysym XF86DualRangeRadar
2025-08-27T13:13:58.810198434Z > Warning: Could not resolve keysym XF86RadarOverlay
2025-08-27T13:13:58.810210909Z > Warning: Could not resolve keysym XF86TraditionalSonar
2025-08-27T13:13:58.810222092Z > Warning: Could not resolve keysym XF86ClearvuSonar
2025-08-27T13:13:58.810232072Z > Warning: Could not resolve keysym XF86SidevuSonar
2025-08-27T13:13:58.810242162Z > Warning: Could not resolve keysym XF86NavInfo
2025-08-27T13:13:58.825967974Z Errors from xkbcomp are not fatal to the X server
2025-08-27T13:13:58.892058009Z xsettingsd: Created window 0x200001 on screen 0 with timestamp 2501958280
2025-08-27T13:13:58.893388438Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-08-27T13:13:58.893601147Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-08-27T13:13:59.227541501Z 19
2025-08-27T13:13:59.526483559Z 20
2025-08-27T13:14:01.433597085Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-08-27T13:14:02.040482338Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-08-27T13:14:02.821534342Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-08-27T13:14:03.676617175Z INFO:main:Upload directory ensured: /config/Desktop
2025-08-27T13:14:03.699330720Z 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-27T13:14:03.699806658Z INFO:main:Initial Encoder: x264enc, Framerate: 60, Bitrate: 16000kbps
2025-08-27T13:14:03.700331696Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-08-27T13:14:03.701777347Z INFO:main:All main components initialized. Running server...
2025-08-27T13:14:03.749809714Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-08-27T13:14:03.789943032Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-08-27T13:14:03.806457162Z INFO:webrtc_input:Starting clipboard monitor
2025-08-27T13:14:03.819570552Z INFO:webrtc_input:Found XFIXES version 4.0
2025-08-27T13:14:03.819877079Z INFO:webrtc_input:starting cursor monitor
2025-08-27T13:14:03.820543702Z INFO:webrtc_input:watching for cursor changes
2025-08-27T13:14:03.934887670Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-27T13:14:03.945802923Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-08-27T13:14:04.730692095Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-08-27T13:14:04.734901212Z 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-27T13:14:04.735262540Z 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-27T13:14:04.735740953Z 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-27T13:14:04.736773603Z 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-27T13:14:04.737101504Z 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-27T13:14:04.737493513Z 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-27T13:14:04.738400640Z 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-27T13:14:04.738719913Z 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-27T13:14:04.739113115Z 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-27T13:14:04.740007837Z 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-27T13:14:04.740330227Z 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-27T13:14:04.740844452Z 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-27T13:14:04.745287240Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-08-27T13:14:04.745998983Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-08-27T13:14:04.746892222Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-08-27T13:14:04.747402159Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-08-27T13:14:04.748295969Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-08-27T13:14:04.748764914Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-08-27T13:14:04.749624455Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-08-27T13:14:04.750096876Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-08-27T13:14:04.751366544Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-08-27T13:14:04.751945450Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-08-27T13:14:04.752416578Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-08-27T13:14:04.752923740Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-08-27T13:14:11.843040090Z dbus-daemon[855]: [system] Activating service name='org.freedesktop.login1' requested by ':1.10' (uid=911 pid=1389 comm="/qemu/qemu-aarch64 /usr/lib/firefox/firefox") (using servicehelper)
2025-08-27T13:14:11.860237987Z dbus-daemon[855]: [system] Activating service name='org.freedesktop.timedate1' requested by ':1.10' (uid=911 pid=1389 comm="/qemu/qemu-aarch64 /usr/lib/firefox/firefox") (using servicehelper)
2025-08-27T13:14:11.866553917Z dbus-daemon[855]: [system] Activated service 'org.freedesktop.login1' failed: Failed to execute program org.freedesktop.login1: Permission denied
2025-08-27T13:14:52.468316413Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-08-27T13:15:07.277499756Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 53748)
2025-08-27T13:15:07.283661486Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1024, "height": 768}
2025-08-27T13:15:07.284892275Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 53748)
2025-08-27T13:15:07.306066369Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-08-27T13:15:07.376346132Z INFO:data_websocket:PulseAudio connection established.
2025-08-27T13:15:07.387826904Z 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-27T13:15:07.388270337Z INFO:gst_app_resize:on_resize_handler attempting resize for: 1920x992
2025-08-27T13:15:07.388626895Z INFO:gst_app_resize:App dimensions updated to 1920x992 before xrandr call.
2025-08-27T13:15:07.458731174Z INFO:gst_app_resize:Mode 1920x992 not found in xrandr list. Attempting to add for screen 'screen'.
2025-08-27T13:15:07.594181930Z INFO:gst_app_resize:Successfully ran: xrandr --newmode 1920x992 158.00 1920 2040 2240 2560 992 995 1005 1029 -hsync +vsync
2025-08-27T13:15:07.676440278Z INFO:gst_app_resize:Successfully ran: xrandr --addmode screen 1920x992
2025-08-27T13:15:07.677114706Z INFO:gst_app_resize:Applying xrandr mode '1920x992' for screen 'screen'.
2025-08-27T13:15:07.768193738Z INFO:gst_app_resize:Successfully applied xrandr mode '1920x992'.
2025-08-27T13:15:07.769345809Z INFO:gst_app_resize:resize_display('1920x992') reported success.
2025-08-27T13:15:07.770419140Z INFO:data_websocket:Applying SCALING_DPI from initial settings: 96
2025-08-27T13:15:07.779685593Z INFO:gst_app_resize:Openbox detected. Applying xrdb for DPI 96.
2025-08-27T13:15:07.783718796Z INFO:gst_app_resize:Wrote 'Xft.dpi: 96' to /config/.Xresources.
2025-08-27T13:15:07.803094598Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-08-27T13:15:08.235830333Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-08-27T13:15:08.237814048Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-08-27T13:15:08.374879196Z INFO:gst_app_resize:Found xsettingsd process with PID: 866.
2025-08-27T13:15:08.438025622Z xsettingsd: Reloading configuration
2025-08-27T13:15:08.440551258Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-08-27T13:15:08.444759153Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 866 to reload config.
2025-08-27T13:15:08.445959661Z INFO:data_websocket:Successfully set DPI to 96 from initial settings.
2025-08-27T13:15:08.447291173Z INFO:data_websocket:Attempting to set cursor size to 32 based on initial DPI.
2025-08-27T13:15:09.065407371Z INFO:data_websocket:Successfully set cursor size to 32.
2025-08-27T13:15:09.066286151Z WARNING:data_websocket:Pipeline is inactive for the initial client. Forcing a start.
2025-08-27T13:15:09.066992203Z INFO:data_websocket:Video pipeline for x264enc needs to start (was not active or forced).
2025-08-27T13:15:09.069103375Z INFO:data_websocket:Starting x264enc: 1920x992 @ 60.0fps, CRF: 25, FullFrame: True
2025-08-27T13:15:09.107089228Z 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-27T13:15:09.107682182Z INFO:data_websocket:Trying to ensure client_settings_received is set for backpressure task start.
2025-08-27T13:15:09.108375378Z INFO:data_websocket:New frame backpressure task started (current encoder: 'x264enc').
2025-08-27T13:15:09.108903883Z INFO:data_websocket:x264enc capture started successfully.
2025-08-27T13:15:09.109679625Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-08-27T13:15:09.110304824Z INFO:data_websocket:Initial setup: Audio pipeline not yet active, attempting start.
2025-08-27T13:15:09.110855573Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-08-27T13:15:09.112109198Z INFO:data_websocket:pcmflux settings: device='', bitrate=320000, channels=2
2025-08-27T13:15:09.113845936Z INFO:data_websocket:Frame-based backpressure logic task started.
2025-08-27T13:15:09.114880990Z INFO:data_websocket:Client settings received, proceeding with backpressure loop.
2025-08-27T13:15:09.118586774Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-08-27T13:15:09.121242382Z [pcmflux] Attempting to connect to PulseAudio device: system_default...
2025-08-27T13:15:09.142628965Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-08-27T13:15:09.178830214Z X Shared Memory Extension available.
2025-08-27T13:15:09.181916690Z XShm setup complete for 1920x992.
2025-08-27T13:15:09.182660017Z CPU cores available: 64
2025-08-27T13:15:09.195058517Z WARNING:webrtc_input:No clipboard content to send
2025-08-27T13:15:09.196351291Z INFO:data_websocket:Received START_VIDEO for encoder: x264enc
2025-08-27T13:15:09.197081972Z INFO:data_websocket:x264enc pipeline is already capturing.
2025-08-27T13:15:09.199076168Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-08-27T13:15:09.200301276Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-08-27T13:15:09.279353577Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-08-27T13:15:09.282695076Z [pcmflux] SUCCESS: Opus encoder created.
2025-08-27T13:15:09.289274647Z [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-27T13:15:09.616838537Z INFO:data_websocket:Frame-based backpressure logic task finished.
2025-08-27T13:15:10.225841712Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 6.00 EncStripes/s: 6.00
2025-08-27T13:15:11.244758799Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-27T13:15:11.268356084Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-08-27T13:15:11.324239172Z [pcmflux] Status | Read: 1, Silent: 0 (0.0%), Encoded: 1, Rate: 0.01 kbps
2025-08-27T13:15:12.265703680Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-27T13:15:13.273037919Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-27T13:15:13.326589231Z [pcmflux] Status | Read: 32, Silent: 0 (0.0%), Encoded: 32, Rate: 0.38 kbps
2025-08-27T13:15:14.278019049Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-27T13:15:15.295407657Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-08-27T13:15:15.330140288Z [pcmflux] Status | Read: 101, Silent: 0 (0.0%), Encoded: 101, Rate: 1.21 kbps
2025-08-27T13:15:16.305215999Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 7.00 EncStripes/s: 7.00
2025-08-27T13:15:17.324361184Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 2.00 EncStripes/s: 2.00
2025-08-27T13:15:17.330826205Z [pcmflux] Status | Read: 107, Silent: 0 (0.0%), Encoded: 107, Rate: 1.28 kbps
2025-08-27T13:15:17.387468161Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 53748)...
2025-08-27T13:15:17.399941763Z INFO:data_websocket:No other clients in set after ('127.0.0.1', 53748) disconnected. Marking pipelines for stop.
2025-08-27T13:15:17.400488794Z INFO:data_websocket:Stopping global pipelines due to last client disconnect (('127.0.0.1', 53748)).
2025-08-27T13:15:17.400814009Z INFO:main:Initiating unified pipeline shutdown...
2025-08-27T13:15:17.404564833Z INFO:data_websocket:Stats sender: WS connection closed.
2025-08-27T13:15:17.411612838Z INFO:main:Queueing x264-striped capture stop.
2025-08-27T13:15:17.412165882Z INFO:main:Queueing pcmflux audio capture stop.
2025-08-27T13:15:17.415879742Z [pcmflux] Stop requested. Cleaning up capture loop...
2025-08-27T13:15:17.416223794Z INFO:main:Waiting for 2 capture module(s) to stop...
2025-08-27T13:15:17.421423838Z [pcmflux] Audio capture loop finished. Resources released.