2025-12-21T22:00:27.516440643Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-12-21T22:00:27.516463108Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-12-21T22:00:27.563818012Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-12-21T22:00:27.593055914Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-12-21T22:00:27.595618052Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-12-21T22:00:27.595732763Z s6-rc: info: service fix-attrs: starting
2025-12-21T22:00:27.595837884Z s6-rc: info: service init-migrations: starting
2025-12-21T22:00:27.596019901Z s6-rc: info: service init-envfile: starting
2025-12-21T22:00:27.601217845Z s6-rc: info: service fix-attrs successfully started
2025-12-21T22:00:27.601344440Z s6-rc: info: service legacy-cont-init: starting
2025-12-21T22:00:27.601485995Z [migrations] started
2025-12-21T22:00:27.601552709Z [migrations] no migrations found
2025-12-21T22:00:27.602586961Z s6-rc: info: service init-migrations successfully started
2025-12-21T22:00:27.602703165Z s6-rc: info: service init-adduser: starting
2025-12-21T22:00:27.603696585Z s6-rc: info: service init-envfile successfully started
2025-12-21T22:00:27.607061830Z s6-rc: info: service legacy-cont-init successfully started
2025-12-21T22:00:27.631152830Z usermod: no changes
2025-12-21T22:00:27.639199981Z ───────────────────────────────────────
2025-12-21T22:00:27.639224881Z 
2025-12-21T22:00:27.639233408Z       ██╗     ███████╗██╗ ██████╗
2025-12-21T22:00:27.639241103Z       ██║     ██╔════╝██║██╔═══██╗
2025-12-21T22:00:27.639248428Z       ██║     ███████╗██║██║   ██║
2025-12-21T22:00:27.639255723Z       ██║     ╚════██║██║██║   ██║
2025-12-21T22:00:27.639262988Z       ███████╗███████║██║╚██████╔╝
2025-12-21T22:00:27.639270292Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-12-21T22:00:27.639277697Z 
2025-12-21T22:00:27.639284621Z    Brought to you by linuxserver.io
2025-12-21T22:00:27.639291776Z ───────────────────────────────────────
2025-12-21T22:00:27.639453962Z 
2025-12-21T22:00:27.639473511Z To support LSIO projects visit:
2025-12-21T22:00:27.639482159Z https://www.linuxserver.io/donate/
2025-12-21T22:00:27.639489684Z 
2025-12-21T22:00:27.639496818Z ───────────────────────────────────────
2025-12-21T22:00:27.639532961Z GID/UID
2025-12-21T22:00:27.639540326Z ───────────────────────────────────────
2025-12-21T22:00:27.642846021Z 
2025-12-21T22:00:27.642867484Z User UID:    911
2025-12-21T22:00:27.642876132Z User GID:    911
2025-12-21T22:00:27.642883597Z ───────────────────────────────────────
2025-12-21T22:00:27.660222463Z s6-rc: info: service init-adduser successfully started
2025-12-21T22:00:27.660460341Z s6-rc: info: service init-device-perms: starting
2025-12-21T22:00:27.665813148Z s6-rc: info: service init-device-perms successfully started
2025-12-21T22:00:27.666050325Z s6-rc: info: service init-os-end: starting
2025-12-21T22:00:27.667437468Z s6-rc: info: service init-os-end successfully started
2025-12-21T22:00:27.667606638Z s6-rc: info: service init-selkies: starting
2025-12-21T22:00:27.668793758Z s6-rc: info: service init-selkies successfully started
2025-12-21T22:00:27.669001557Z s6-rc: info: service init-nginx: starting
2025-12-21T22:00:27.723630836Z ..+..+.........+.......+...+...........+....+......+........+.+++++++++++++++++++++++++++++++++++++++*......+++++++++++++++++++++++++++++++++++++++*...+.+.........+...+.....+......+....+...+..+.......+...+....................+.+..............+............+..................+.+..+.......+......+......+......+..............+...+.+...........+.+.....+....+........+............+.+........+....+...+.........+..............+.+...+...+.....+...+....+...+........+......+.+.....+...+......+...+.......+...+..+.+...+.....+.......+..+................+..+.......+.....+.+.....+....+......+......+........+.........................+...+........+................+...+..+....+.........+...+..+.+...........+...............+.+............+...+........+....+..+......+...+....+..+.+........................+...+...+.....+.........+.+..+.............+...+.....+.+...+..+...++++++
2025-12-21T22:00:27.738436412Z .....+........+.+......+++++++++++++++++++++++++++++++++++++++*....+.........+.....+....+..+...............+....+.....+.+...+........+...+.+...+.....+.+.....+.+........+...+...+++++++++++++++++++++++++++++++++++++++*....+............+...+................+...............+......+.....+...+..........+..+.....................+...+....+...+.....+....+...........+..........+...+......+.....+.+.........+.....+.+..+......+......+...+................+..++++++
2025-12-21T22:00:27.741785825Z -----
2025-12-21T22:00:27.876855716Z s6-rc: info: service init-nginx successfully started
2025-12-21T22:00:27.877121932Z s6-rc: info: service init-selkies-config: starting
2025-12-21T22:00:27.925822656Z [ls.io-init] Creating initial backup of menu.xml
2025-12-21T22:00:27.967629902Z [ls.io-init] Creating initial backup of system rc.xml
2025-12-21T22:00:28.013793338Z s6-rc: info: service init-selkies-config successfully started
2025-12-21T22:00:28.013973681Z s6-rc: info: service init-video: starting
2025-12-21T22:00:28.028837284Z s6-rc: info: service init-video successfully started
2025-12-21T22:00:28.029069953Z s6-rc: info: service init-selkies-end: starting
2025-12-21T22:00:28.030871048Z s6-rc: info: service init-selkies-end successfully started
2025-12-21T22:00:28.031210341Z s6-rc: info: service init-config: starting
2025-12-21T22:00:28.033073703Z s6-rc: info: service init-config successfully started
2025-12-21T22:00:28.033204185Z s6-rc: info: service init-crontab-config: starting
2025-12-21T22:00:28.041912176Z s6-rc: info: service init-crontab-config successfully started
2025-12-21T22:00:28.042114784Z s6-rc: info: service init-config-end: starting
2025-12-21T22:00:28.043599543Z s6-rc: info: service init-config-end successfully started
2025-12-21T22:00:28.043751409Z s6-rc: info: service init-mods: starting
2025-12-21T22:00:28.045627426Z s6-rc: info: service init-mods successfully started
2025-12-21T22:00:28.045863371Z s6-rc: info: service init-mods-package-install: starting
2025-12-21T22:00:28.053877435Z s6-rc: info: service init-mods-package-install successfully started
2025-12-21T22:00:28.054090002Z s6-rc: info: service init-mods-end: starting
2025-12-21T22:00:28.055687378Z s6-rc: info: service init-mods-end successfully started
2025-12-21T22:00:28.055826799Z s6-rc: info: service init-custom-files: starting
2025-12-21T22:00:28.062795488Z [custom-init] No custom files found, skipping...
2025-12-21T22:00:28.063645630Z s6-rc: info: service init-custom-files successfully started
2025-12-21T22:00:28.063937477Z s6-rc: info: service init-services: starting
2025-12-21T22:00:28.065519452Z s6-rc: info: service init-services successfully started
2025-12-21T22:00:28.065737221Z s6-rc: info: service svc-xorg: starting
2025-12-21T22:00:28.065980721Z s6-rc: info: service svc-watchdog: starting
2025-12-21T22:00:28.066195674Z s6-rc: info: service svc-pulseaudio: starting
2025-12-21T22:00:28.066467922Z s6-rc: info: service svc-nginx: starting
2025-12-21T22:00:28.066569586Z s6-rc: info: service svc-docker: starting
2025-12-21T22:00:28.066883318Z s6-rc: info: service svc-cron: starting
2025-12-21T22:00:28.069292909Z s6-rc: info: service svc-xorg successfully started
2025-12-21T22:00:28.069493864Z s6-rc: info: service svc-dbus: starting
2025-12-21T22:00:28.069797174Z s6-rc: info: service svc-watchdog successfully started
2025-12-21T22:00:28.070040885Z s6-rc: info: service svc-pulseaudio successfully started
2025-12-21T22:00:28.070278734Z s6-rc: info: service svc-nginx successfully started
2025-12-21T22:00:28.070624199Z s6-rc: info: service svc-xsettingsd: starting
2025-12-21T22:00:28.070797338Z s6-rc: info: service svc-de: starting
2025-12-21T22:00:28.071058083Z s6-rc: info: service svc-docker successfully started
2025-12-21T22:00:28.071310451Z s6-rc: info: service svc-cron successfully started
2025-12-21T22:00:28.072208539Z s6-rc: info: service svc-dbus successfully started
2025-12-21T22:00:28.072374363Z s6-rc: info: service svc-selkies: starting
2025-12-21T22:00:28.073097969Z s6-rc: info: service svc-xsettingsd successfully started
2025-12-21T22:00:28.073311549Z s6-rc: info: service svc-de successfully started
2025-12-21T22:00:28.074679533Z s6-rc: info: service svc-selkies successfully started
2025-12-21T22:00:28.074841960Z s6-rc: info: service legacy-services: starting
2025-12-21T22:00:28.083249717Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-12-21T22:00:28.083618469Z xsettingsd: Unable to open connection to X server
2025-12-21T22:00:28.084809497Z s6-rc: info: service legacy-services successfully started
2025-12-21T22:00:28.084949940Z s6-rc: info: service ci-service-check: starting
2025-12-21T22:00:28.086348726Z [ls.io-init] done.
2025-12-21T22:00:28.086539991Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-12-21T22:00:28.086726536Z s6-rc: info: service ci-service-check successfully started
2025-12-21T22:00:28.087227164Z screen 0 shmid 0
2025-12-21T22:00:28.597213182Z 17
2025-12-21T22:00:28.612144171Z 18
2025-12-21T22:00:28.843364472Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-12-21T22:00:28.880004655Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-12-21T22:00:28.923753049Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-12-21T22:00:28.973593758Z INFO:main:Upload directory ensured: /config/Desktop
2025-12-21T22:00:28.974152493Z INFO:main:Legacy Mode ENABLED (SELKIES_MASTER_TOKEN is not set).
2025-12-21T22:00:28.974212974Z INFO:main:Starting Selkies (WebSocket Mode) with settings: {'audio_enabled': (True, False), 'microphone_enabled': (True, False), 'gamepad_enabled': (True, False), 'clipboard_enabled': (True, False), 'command_enabled': (True, False), 'file_transfers': ['upload', 'download'], 'encoder': 'x264enc', 'framerate': (8, 120), 'h264_crf': (5, 50), 'jpeg_quality': (1, 100), 'h264_fullcolor': (False, False), 'h264_streaming_mode': (False, False), 'use_cpu': (False, False), 'use_paint_over_quality': (True, False), 'paint_over_jpeg_quality': (1, 100), 'h264_paintover_crf': (5, 50), 'h264_paintover_burst_frames': (1, 30), 'second_screen': (True, False), 'audio_bitrate': '320000', 'is_manual_resolution_mode': (False, False), 'manual_width': 0, 'manual_height': 0, 'scaling_dpi': '96', 'enable_binary_clipboard': (False, False), 'use_browser_cursors': (False, False), 'use_css_scaling': (False, False), 'ui_title': 'Selkies', 'ui_show_logo': (True, False), 'ui_show_core_buttons': (True, False), 'ui_show_sidebar': (True, False), 'ui_sidebar_show_video_settings': (True, False), 'ui_sidebar_show_screen_settings': (True, False), 'ui_sidebar_show_audio_settings': (True, False), 'ui_sidebar_show_stats': (True, False), 'ui_sidebar_show_clipboard': (True, False), 'ui_sidebar_show_files': (True, False), 'ui_sidebar_show_apps': (True, False), 'ui_sidebar_show_sharing': (True, False), 'ui_sidebar_show_gamepads': (True, False), 'ui_sidebar_show_fullscreen': (True, False), 'ui_sidebar_show_gaming_mode': (True, False), 'ui_sidebar_show_trackpad': (True, False), 'ui_sidebar_show_keyboard_button': (True, False), 'ui_sidebar_show_soft_buttons': (True, False), 'port': 8082, 'control_port': 8083, 'master_token': '', 'dri_node': '', 'audio_device_name': 'output.monitor', 'watermark_path': '', 'watermark_location': -1, 'debug': (False, False), 'enable_sharing': (True, False), 'enable_collab': (True, False), 'enable_shared': (True, False), 'enable_player2': (True, False), 'enable_player3': (True, False), 'enable_player4': (True, False)}
2025-12-21T22:00:28.974236271Z INFO:main:Initial Encoder: x264enc, Framerate: 60
2025-12-21T22:00:28.974255069Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-12-21T22:00:28.974383678Z INFO:main:All main components initialized. Running server...
2025-12-21T22:00:28.976949333Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-12-21T22:00:28.979387452Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-12-21T22:00:28.980349148Z INFO:webrtc_input:Clipboard monitor running (binary mode: False)
2025-12-21T22:00:28.981078085Z INFO:webrtc_input:Found XFIXES version 4.0
2025-12-21T22:00:28.981105049Z INFO:webrtc_input:starting cursor monitor
2025-12-21T22:00:28.981116893Z INFO:webrtc_input:watching for cursor changes
2025-12-21T22:00:28.987542349Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-12-21T22:00:28.987997596Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-12-21T22:00:29.100447959Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-12-21T22:00:29.101075463Z xsettingsd: Created window 0x1200001 on screen 0 with timestamp 3966013901
2025-12-21T22:00:29.101101365Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-12-21T22:00:29.101114882Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-12-21T22:00:29.112812922Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-12-21T22:00:29.113057374Z 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-12-21T22:00:29.113082335Z 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-12-21T22:00:29.113095251Z 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-12-21T22:00:29.113152486Z 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-12-21T22:00:29.113179570Z 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-12-21T22:00:29.113191735Z 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-12-21T22:00:29.113238820Z 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-12-21T22:00:29.113250664Z 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-12-21T22:00:29.113259401Z 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-12-21T22:00:29.113297458Z 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-12-21T22:00:29.113315825Z 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-12-21T22:00:29.113328631Z 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-12-21T22:00:29.113899921Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-12-21T22:00:29.113921674Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-12-21T22:00:29.114037568Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-12-21T22:00:29.114047999Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-12-21T22:00:29.114240276Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-12-21T22:00:29.114261749Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-12-21T22:00:29.114321550Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-12-21T22:00:29.114331049Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-12-21T22:00:29.114546843Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-12-21T22:00:29.114577966Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-12-21T22:00:29.114587936Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-12-21T22:00:29.114596283Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-12-21T22:00:29.489899018Z dbus-daemon[293]: [system] Activating service name='org.freedesktop.login1' requested by ':1.26' (uid=911 pid=477 comm="/opt/zen/zen") (using servicehelper)
2025-12-21T22:00:29.490392892Z dbus-daemon[293]: [system] Activating service name='org.freedesktop.timedate1' requested by ':1.26' (uid=911 pid=477 comm="/opt/zen/zen") (using servicehelper)
2025-12-21T22:00:29.491685875Z dbus-daemon[293]: [system] Activated service 'org.freedesktop.login1' failed: Failed to execute program org.freedesktop.login1: Permission denied
2025-12-21T22:00:30.948252040Z INFO:data_websocket:Legacy client ('127.0.0.1', 57296) connected. Role: controller, Slot: None
2025-12-21T22:00:30.948292671Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 57296)
2025-12-21T22:00:30.948364406Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 57296)
2025-12-21T22:00:30.949327865Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-12-21T22:00:30.951074351Z INFO:data_websocket:PulseAudio connection established.
2025-12-21T22:00:30.971289889Z INFO:data_websocket:Registering new client for display: primary
2025-12-21T22:00:30.971316152Z INFO:data_websocket:Applying and sanitizing client settings for 'primary' (initial=True)
2025-12-21T22:00:30.971409971Z INFO:data_websocket:DPI changed from None to 96. Applying system-level change.
2025-12-21T22:00:30.972177727Z INFO:gst_app_resize:Openbox detected. Applying xrdb for DPI 96.
2025-12-21T22:00:30.972486027Z INFO:gst_app_resize:Wrote 'Xft.dpi:   96' to /config/.Xresources.
2025-12-21T22:00:30.985844450Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-12-21T22:00:30.986039423Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-12-21T22:00:31.003195240Z INFO:gst_app_resize:Found xsettingsd process with PID: 466.
2025-12-21T22:00:31.004771173Z xsettingsd: Reloading configuration
2025-12-21T22:00:31.004800522Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-12-21T22:00:31.005160627Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 466 to reload config.
2025-12-21T22:00:31.026242078Z INFO:data_websocket:Initial setup or dimensional change detected for 'primary'. Performing full display reconfiguration.
2025-12-21T22:00:31.026258832Z INFO:data_websocket:Starting display reconfiguration...
2025-12-21T22:00:31.026400457Z INFO:data_websocket:Calculating new extended desktop layout from ALL clients...
2025-12-21T22:00:31.026421790Z INFO:data_websocket:Layout calculated: Total Size=1920x992. Layouts: {'primary': {'x': 0, 'y': 0, 'w': 1920, 'h': 992}}
2025-12-21T22:00:31.035100682Z INFO:data_websocket:Mode 1920x992 not found. Creating it.
2025-12-21T22:00:31.045503235Z INFO:data_websocket:Defining logical monitors for the window manager...
2025-12-21T22:00:31.051280145Z INFO:data_websocket:Starting separate capture instances for each ACTIVE display region...
2025-12-21T22:00:31.051312009Z INFO:data_websocket:Client 'primary' is active. Starting its capture.
2025-12-21T22:00:31.051323973Z INFO:data_websocket:Preparing to start capture for display='primary': Res=1920x992, Offset=0x0
2025-12-21T22:00:31.052783101Z INFO:data_websocket:Video chunk sender started for display 'primary'.
2025-12-21T22:00:31.053179869Z INFO:data_websocket:SUCCESS: Capture started for 'primary'.
2025-12-21T22:00:31.053198647Z INFO:data_websocket:New frame backpressure task started for display 'primary'.
2025-12-21T22:00:31.053246393Z INFO:data_websocket:Broadcasting primary stream resolution to all clients: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-12-21T22:00:31.053347717Z INFO:data_websocket:Broadcasting display config update: DISPLAY_CONFIG_UPDATE,{"type": "display_config_update", "displays": ["primary"]}
2025-12-21T22:00:31.053407147Z INFO:data_websocket:Display reconfiguration finished successfully.
2025-12-21T22:00:31.053430755Z INFO:data_websocket:Reconfiguration process complete (state unlocked).
2025-12-21T22:00:31.053504303Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-12-21T22:00:31.053538822Z INFO:data_websocket:Initial setup: Primary client connected, audio not active, attempting start.
2025-12-21T22:00:31.053548061Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-12-21T22:00:31.053629404Z INFO:data_websocket:pcmflux settings: device='output.monitor', bitrate=320000, channels=2
2025-12-21T22:00:31.053707051Z INFO:data_websocket:Frame-based backpressure logic task started for display 'primary'.
2025-12-21T22:00:31.053719706Z INFO:data_websocket:Client settings received, proceeding with backpressure loop for 'primary'.
2025-12-21T22:00:31.053940591Z [pcmflux] Attempting to connect to PulseAudio device: output.monitor...
2025-12-21T22:00:31.053959018Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-12-21T22:00:31.054824591Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-12-21T22:00:31.055430671Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-12-21T22:00:31.055469449Z [pcmflux] SUCCESS: Opus encoder created.
2025-12-21T22:00:31.055483217Z [pcmflux] Capture loop started. Device: output.monitor, Rate: 48000, Channels: 2, Bitrate: 320 kbps, VBR: On, Silence Gate: Off, Debug Logging: Off, PCM Chunk: 3840 bytes
2025-12-21T22:00:31.055840616Z X Shared Memory Extension available.
2025-12-21T22:00:31.055910016Z XShm setup complete for 1920x992.
2025-12-21T22:00:31.055937742Z CPU cores available: 64
2025-12-21T22:00:31.055949305Z Stream settings active -> Res: 1920x992 | FPS: 60.0 | Stripes: 1 | Mode: H264 (CPU) FullFrame | CRF: 25 | PaintOver CRF: 18 (Burst: 5f) | Colorspace: I420 (Limited Range) | Damage Thresh: 10f | Damage Dur: 20f
2025-12-21T22:00:31.058775855Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-12-21T22:00:31.058808871Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-12-21T22:00:31.058974916Z INFO:data_websocket:Client is taking over existing display 'primary'. Updating state for new connection.
2025-12-21T22:00:31.059001810Z INFO:data_websocket:Applying and sanitizing client settings for 'primary' (initial=False)
2025-12-21T22:00:31.059132363Z INFO:data_websocket:Received redundant resize request for primary (1920x992). No action taken.
2025-12-21T22:00:33.056509343Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-12-21T22:00:41.209740836Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 57296) (Display ID: primary)...
2025-12-21T22:00:41.209843804Z INFO:data_websocket:Client for 'primary' disconnected. Removing and triggering full display reconfiguration.
2025-12-21T22:00:41.209870457Z INFO:data_websocket:Starting display reconfiguration...
2025-12-21T22:00:41.209914706Z INFO:data_websocket:Stopping all existing capture and backpressure tasks...
2025-12-21T22:00:41.230328754Z Capture loop stopped. X resources released.
2025-12-21T22:00:41.230645722Z INFO:data_websocket:All capture instances, senders, and backpressure tasks stopped.
2025-12-21T22:00:41.230666053Z WARNING:data_websocket:No display clients connected. Video pipelines remain stopped.
2025-12-21T22:00:41.231698261Z INFO:data_websocket:Video chunk sender for 'primary' cancelled.
2025-12-21T22:00:41.231703041Z INFO:data_websocket:Video chunk sender for 'primary' finished.
2025-12-21T22:00:41.243805876Z INFO:data_websocket:Reconfiguration process complete (state unlocked).
2025-12-21T22:00:41.250176491Z INFO:data_websocket:Last client (('127.0.0.1', 57296)) disconnected. All pipelines should have been stopped by reconfigure_displays.
2025-12-21T22:00:41.250215760Z INFO:main:Initiating unified pipeline shutdown...
2025-12-21T22:00:41.250244669Z WARNING:data_websocket:Reconfiguration already in progress. Ignoring concurrent request.
2025-12-21T22:00:41.250273016Z INFO:data_websocket:Stopping pcmflux audio pipeline...
2025-12-21T22:00:41.250346353Z INFO:data_websocket:pcmflux audio chunk broadcasting task cancelled.
2025-12-21T22:00:41.250375813Z INFO:data_websocket:pcmflux audio chunk broadcasting task finished.