2025-11-27T04:07:45.558294910Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-11-27T04:07:45.558313157Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-11-27T04:07:45.603609581Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-11-27T04:07:45.636287938Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-11-27T04:07:45.638899306Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-11-27T04:07:45.639170943Z s6-rc: info: service fix-attrs: starting
2025-11-27T04:07:45.639439353Z s6-rc: info: service init-migrations: starting
2025-11-27T04:07:45.639545908Z s6-rc: info: service init-envfile: starting
2025-11-27T04:07:45.645154541Z [migrations] started
2025-11-27T04:07:45.645207708Z [migrations] no migrations found
2025-11-27T04:07:45.645773076Z s6-rc: info: service init-migrations successfully started
2025-11-27T04:07:45.645912437Z s6-rc: info: service init-adduser: starting
2025-11-27T04:07:45.646037489Z s6-rc: info: service fix-attrs successfully started
2025-11-27T04:07:45.646210217Z s6-rc: info: service legacy-cont-init: starting
2025-11-27T04:07:45.647696098Z s6-rc: info: service init-envfile successfully started
2025-11-27T04:07:45.652404609Z s6-rc: info: service legacy-cont-init successfully started
2025-11-27T04:07:45.673336385Z usermod: no changes
2025-11-27T04:07:45.683439638Z ───────────────────────────────────────
2025-11-27T04:07:45.683451341Z
2025-11-27T04:07:45.683455400Z ██╗ ███████╗██╗ ██████╗
2025-11-27T04:07:45.683459398Z ██║ ██╔════╝██║██╔═══██╗
2025-11-27T04:07:45.683463366Z ██║ ███████╗██║██║ ██║
2025-11-27T04:07:45.683467213Z ██║ ╚════██║██║██║ ██║
2025-11-27T04:07:45.683470991Z ███████╗███████║██║╚██████╔╝
2025-11-27T04:07:45.683474799Z ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-11-27T04:07:45.683480851Z
2025-11-27T04:07:45.683484488Z Brought to you by linuxserver.io
2025-11-27T04:07:45.683488166Z ───────────────────────────────────────
2025-11-27T04:07:45.683823871Z
2025-11-27T04:07:45.683832449Z To support LSIO projects visit:
2025-11-27T04:07:45.683836246Z https://www.linuxserver.io/donate/
2025-11-27T04:07:45.683839773Z
2025-11-27T04:07:45.683897329Z ───────────────────────────────────────
2025-11-27T04:07:45.683917410Z GID/UID
2025-11-27T04:07:45.683921047Z ───────────────────────────────────────
2025-11-27T04:07:45.688076975Z
2025-11-27T04:07:45.688088358Z User UID: 911
2025-11-27T04:07:45.688092226Z User GID: 911
2025-11-27T04:07:45.688095973Z ───────────────────────────────────────
2025-11-27T04:07:45.688994482Z Linuxserver.io version: v4.12.1-ls164
2025-11-27T04:07:45.691756574Z Build-date: 2025-11-27T03:58:45+00:00
2025-11-27T04:07:45.691772155Z ───────────────────────────────────────
2025-11-27T04:07:45.691777246Z
2025-11-27T04:07:45.707282916Z s6-rc: info: service init-adduser successfully started
2025-11-27T04:07:45.707453439Z s6-rc: info: service init-device-perms: starting
2025-11-27T04:07:45.712386182Z s6-rc: info: service init-device-perms successfully started
2025-11-27T04:07:45.712520362Z s6-rc: info: service init-os-end: starting
2025-11-27T04:07:45.713966874Z s6-rc: info: service init-os-end successfully started
2025-11-27T04:07:45.714096435Z s6-rc: info: service init-selkies: starting
2025-11-27T04:07:45.715234426Z s6-rc: info: service init-selkies successfully started
2025-11-27T04:07:45.715350230Z s6-rc: info: service init-nginx: starting
2025-11-27T04:07:45.750508480Z ....+.........+.........+.........+..+.+..+..........+.....+...+..........+...+............+........+.+.....+...+.+.........+..+.+..+...+...+.+...........+++++++++++++++++++++++++++++++++++++++*.....+.+...+..+...+......+...+.+......+...+..+......+..........+.........+...+..+.+........+.+++++++++++++++++++++++++++++++++++++++*.......+.....+.........+.+...............+...+......+.....+.........+....+...+...+.................+.......+.....+...+....+...+...+........+....+..+....+.....+.+.........+............+..+............+.........+.......+...+......+...+........+...+.+........+...+...+.+.........+....................+.+........+...+....+......+.....+...+.......+...+......+...................................++++++
2025-11-27T04:07:45.765040741Z ...+.+...+...........+++++++++++++++++++++++++++++++++++++++*..+.........+..+......+....+.....+++++++++++++++++++++++++++++++++++++++*.+...+..+............+.+..+....+...+..+..........+...+...+...+..+...+......+.........+..........+......+...........+.......+......+.....+....+.....+...+.........+....+......+...+........+..........++++++
2025-11-27T04:07:45.768387259Z -----
2025-11-27T04:07:45.959410622Z s6-rc: info: service init-nginx successfully started
2025-11-27T04:07:45.959660816Z s6-rc: info: service init-selkies-config: starting
2025-11-27T04:07:45.997472470Z [ls.io-init] Creating initial backup of menu.xml
2025-11-27T04:07:46.029379865Z [ls.io-init] Creating initial backup of system rc.xml
2025-11-27T04:07:46.079292543Z s6-rc: info: service init-selkies-config successfully started
2025-11-27T04:07:46.079386302Z s6-rc: info: service init-video: starting
2025-11-27T04:07:46.091035578Z s6-rc: info: service init-video successfully started
2025-11-27T04:07:46.091189107Z s6-rc: info: service init-selkies-end: starting
2025-11-27T04:07:46.092577312Z s6-rc: info: service init-selkies-end successfully started
2025-11-27T04:07:46.092858779Z s6-rc: info: service init-config: starting
2025-11-27T04:07:46.094515134Z s6-rc: info: service init-config successfully started
2025-11-27T04:07:46.094700718Z s6-rc: info: service init-crontab-config: starting
2025-11-27T04:07:46.101161076Z s6-rc: info: service init-crontab-config successfully started
2025-11-27T04:07:46.101347731Z s6-rc: info: service init-config-end: starting
2025-11-27T04:07:46.102734644Z s6-rc: info: service init-config-end successfully started
2025-11-27T04:07:46.102884927Z s6-rc: info: service init-mods: starting
2025-11-27T04:07:46.104476241Z s6-rc: info: service init-mods successfully started
2025-11-27T04:07:46.104653097Z s6-rc: info: service init-mods-package-install: starting
2025-11-27T04:07:46.113202711Z s6-rc: info: service init-mods-package-install successfully started
2025-11-27T04:07:46.113408065Z s6-rc: info: service init-mods-end: starting
2025-11-27T04:07:46.114919618Z s6-rc: info: service init-mods-end successfully started
2025-11-27T04:07:46.115076304Z s6-rc: info: service init-custom-files: starting
2025-11-27T04:07:46.122114645Z [custom-init] No custom files found, skipping...
2025-11-27T04:07:46.122931821Z s6-rc: info: service init-custom-files successfully started
2025-11-27T04:07:46.123242607Z s6-rc: info: service init-services: starting
2025-11-27T04:07:46.124970796Z s6-rc: info: service init-services successfully started
2025-11-27T04:07:46.125123824Z s6-rc: info: service svc-xorg: starting
2025-11-27T04:07:46.125259578Z s6-rc: info: service svc-watchdog: starting
2025-11-27T04:07:46.125482376Z s6-rc: info: service svc-pulseaudio: starting
2025-11-27T04:07:46.125643621Z s6-rc: info: service svc-nginx: starting
2025-11-27T04:07:46.125787200Z s6-rc: info: service svc-docker: starting
2025-11-27T04:07:46.125989006Z s6-rc: info: service svc-cron: starting
2025-11-27T04:07:46.127612586Z s6-rc: info: service svc-xorg successfully started
2025-11-27T04:07:46.127733339Z s6-rc: info: service svc-dbus: starting
2025-11-27T04:07:46.127907620Z s6-rc: info: service svc-watchdog successfully started
2025-11-27T04:07:46.128046960Z s6-rc: info: service svc-pulseaudio successfully started
2025-11-27T04:07:46.128236201Z s6-rc: info: service svc-nginx successfully started
2025-11-27T04:07:46.128497337Z s6-rc: info: service svc-xsettingsd: starting
2025-11-27T04:07:46.128614363Z s6-rc: info: service svc-de: starting
2025-11-27T04:07:46.128756509Z s6-rc: info: service svc-docker successfully started
2025-11-27T04:07:46.128894757Z s6-rc: info: service svc-cron successfully started
2025-11-27T04:07:46.130183973Z s6-rc: info: service svc-dbus successfully started
2025-11-27T04:07:46.130323003Z s6-rc: info: service svc-selkies: starting
2025-11-27T04:07:46.130463155Z s6-rc: info: service svc-xsettingsd successfully started
2025-11-27T04:07:46.131166131Z s6-rc: info: service svc-de successfully started
2025-11-27T04:07:46.132747625Z s6-rc: info: service svc-selkies successfully started
2025-11-27T04:07:46.132928249Z s6-rc: info: service legacy-services: starting
2025-11-27T04:07:46.140805550Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-11-27T04:07:46.141273742Z screen 0 shmid 0
2025-11-27T04:07:46.142377064Z s6-rc: info: service legacy-services successfully started
2025-11-27T04:07:46.142559421Z s6-rc: info: service ci-service-check: starting
2025-11-27T04:07:46.143129639Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-11-27T04:07:46.144191738Z [ls.io-init] done.
2025-11-27T04:07:46.144593827Z s6-rc: info: service ci-service-check successfully started
2025-11-27T04:07:46.710233166Z xsettingsd: Created window 0x200001 on screen 0 with timestamp 1828051510
2025-11-27T04:07:46.710270511Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-11-27T04:07:46.710279830Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-11-27T04:07:46.727035988Z 17
2025-11-27T04:07:46.743257059Z 18
2025-11-27T04:07:46.965476195Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-11-27T04:07:47.000745740Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-11-27T04:07:47.047878281Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-11-27T04:07:47.093742698Z INFO:main:Upload directory ensured: /config/Desktop
2025-11-27T04:07:47.094084627Z INFO:main:Legacy Mode ENABLED (SELKIES_MASTER_TOKEN is not set).
2025-11-27T04:07:47.094155429Z 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-11-27T04:07:47.094192544Z INFO:main:Initial Encoder: x264enc, Framerate: 60
2025-11-27T04:07:47.094203326Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-11-27T04:07:47.094298768Z INFO:main:All main components initialized. Running server...
2025-11-27T04:07:47.096869614Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-11-27T04:07:47.099196289Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-11-27T04:07:47.100220351Z INFO:webrtc_input:Clipboard monitor running (binary mode: False)
2025-11-27T04:07:47.101078449Z INFO:webrtc_input:Found XFIXES version 4.0
2025-11-27T04:07:47.101121676Z INFO:webrtc_input:starting cursor monitor
2025-11-27T04:07:47.101134922Z INFO:webrtc_input:watching for cursor changes
2025-11-27T04:07:47.107767848Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-11-27T04:07:47.108260490Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-11-27T04:07:47.234054054Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-11-27T04:07:47.234237703Z 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-11-27T04:07:47.234263976Z 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-11-27T04:07:47.234302634Z 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-11-27T04:07:47.234345821Z 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-11-27T04:07:47.234357104Z 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-11-27T04:07:47.234373868Z 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-11-27T04:07:47.234445191Z 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-11-27T04:07:47.234481534Z 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-11-27T04:07:47.234495242Z 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-11-27T04:07:47.234507216Z 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-11-27T04:07:47.234516525Z 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-11-27T04:07:47.234545463Z 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-11-27T04:07:47.235012784Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-11-27T04:07:47.235050159Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-11-27T04:07:47.235206875Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-11-27T04:07:47.235219120Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-11-27T04:07:47.235302828Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-11-27T04:07:47.235318830Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-11-27T04:07:47.235415876Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-11-27T04:07:47.235429704Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-11-27T04:07:47.235566559Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-11-27T04:07:47.235593463Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-11-27T04:07:47.235608874Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-11-27T04:07:47.235630498Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-11-27T04:07:48.449756067Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-11-27T04:07:48.471583787Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-11-27T04:07:50.025957672Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-11-27T04:07:50.208763309Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-11-27T04:09:41.861887418Z INFO:data_websocket:Legacy client ('127.0.0.1', 58834) connected. Role: controller, Slot: None
2025-11-27T04:09:41.861921396Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 58834)
2025-11-27T04:09:41.862107882Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 58834)
2025-11-27T04:09:41.863505686Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-11-27T04:09:41.866338991Z INFO:data_websocket:PulseAudio connection established.
2025-11-27T04:09:41.890154954Z INFO:data_websocket:Registering new client for display: primary
2025-11-27T04:09:41.890206147Z INFO:data_websocket:Applying and sanitizing client settings for 'primary' (initial=True)
2025-11-27T04:09:41.890344726Z INFO:data_websocket:DPI changed from None to 96. Applying system-level change.
2025-11-27T04:09:41.891521936Z INFO:gst_app_resize:Openbox detected. Applying xrdb for DPI 96.
2025-11-27T04:09:41.892785220Z INFO:gst_app_resize:Wrote 'Xft.dpi: 96' to /config/.Xresources.
2025-11-27T04:09:41.920922033Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-11-27T04:09:41.921176055Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-11-27T04:09:41.937349910Z INFO:gst_app_resize:Found xsettingsd process with PID: 288.
2025-11-27T04:09:41.939077488Z xsettingsd: Reloading configuration
2025-11-27T04:09:41.939163892Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-11-27T04:09:41.939474287Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 288 to reload config.
2025-11-27T04:09:41.964901244Z INFO:data_websocket:Initial setup or dimensional change detected for 'primary'. Performing full display reconfiguration.
2025-11-27T04:09:41.964913880Z INFO:data_websocket:Starting display reconfiguration...
2025-11-27T04:09:41.965102349Z INFO:data_websocket:Calculating new extended desktop layout from ALL clients...
2025-11-27T04:09:41.965144384Z INFO:data_websocket:Layout calculated: Total Size=1920x992. Layouts: {'primary': {'x': 0, 'y': 0, 'w': 1920, 'h': 992}}
2025-11-27T04:09:41.977617218Z INFO:data_websocket:Mode 1920x992 not found. Creating it.
2025-11-27T04:09:41.990389504Z INFO:data_websocket:Defining logical monitors for the window manager...
2025-11-27T04:09:41.998179289Z INFO:data_websocket:Starting separate capture instances for each ACTIVE display region...
2025-11-27T04:09:41.998202376Z INFO:data_websocket:Client 'primary' is active. Starting its capture.
2025-11-27T04:09:41.998227757Z INFO:data_websocket:Preparing to start capture for display='primary': Res=1920x992, Offset=0x0
2025-11-27T04:09:41.999421079Z INFO:data_websocket:Video chunk sender started for display 'primary'.
2025-11-27T04:09:42.000313025Z INFO:data_websocket:SUCCESS: Capture started for 'primary'.
2025-11-27T04:09:42.000345350Z INFO:data_websocket:New frame backpressure task started for display 'primary'.
2025-11-27T04:09:42.000405552Z INFO:data_websocket:Broadcasting primary stream resolution to all clients: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-11-27T04:09:42.000564061Z INFO:data_websocket:Broadcasting display config update: DISPLAY_CONFIG_UPDATE,{"type": "display_config_update", "displays": ["primary"]}
2025-11-27T04:09:42.000621927Z INFO:data_websocket:Display reconfiguration finished successfully.
2025-11-27T04:09:42.000639152Z INFO:data_websocket:Reconfiguration process complete (state unlocked).
2025-11-27T04:09:42.000732660Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-11-27T04:09:42.000760637Z INFO:data_websocket:Initial setup: Primary client connected, audio not active, attempting start.
2025-11-27T04:09:42.000777390Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-11-27T04:09:42.000817050Z INFO:data_websocket:pcmflux settings: device='output.monitor', bitrate=320000, channels=2
2025-11-27T04:09:42.000914456Z INFO:data_websocket:Frame-based backpressure logic task started for display 'primary'.
2025-11-27T04:09:42.000940779Z INFO:data_websocket:Client settings received, proceeding with backpressure loop for 'primary'.
2025-11-27T04:09:42.001199079Z [pcmflux] Attempting to connect to PulseAudio device: output.monitor...
2025-11-27T04:09:42.001217026Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-11-27T04:09:42.002026616Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-11-27T04:09:42.002376520Z X Shared Memory Extension available.
2025-11-27T04:09:42.002479678Z XShm setup complete for 1920x992.
2025-11-27T04:09:42.002531382Z CPU cores available: 64
2025-11-27T04:09:42.002567765Z 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-11-27T04:09:42.003158926Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-11-27T04:09:42.003212994Z [pcmflux] SUCCESS: Opus encoder created.
2025-11-27T04:09:42.003217984Z [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-11-27T04:09:42.006380592Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-11-27T04:09:42.006424912Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-11-27T04:09:42.006642239Z INFO:data_websocket:Client is taking over existing display 'primary'. Updating state for new connection.
2025-11-27T04:09:42.006675145Z INFO:data_websocket:Applying and sanitizing client settings for 'primary' (initial=False)
2025-11-27T04:09:42.006831320Z INFO:data_websocket:Received redundant resize request for primary (1920x992). No action taken.
2025-11-27T04:09:44.004364596Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-11-27T04:09:52.287603081Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 58834) (Display ID: primary)...
2025-11-27T04:09:52.287683903Z INFO:data_websocket:Client for 'primary' disconnected. Removing and triggering full display reconfiguration.
2025-11-27T04:09:52.287698663Z INFO:data_websocket:Starting display reconfiguration...
2025-11-27T04:09:52.287708002Z INFO:data_websocket:Stopping all existing capture and backpressure tasks...
2025-11-27T04:09:52.310714695Z Capture loop stopped. X resources released.
2025-11-27T04:09:52.311050652Z INFO:data_websocket:All capture instances, senders, and backpressure tasks stopped.
2025-11-27T04:09:52.311079700Z WARNING:data_websocket:No display clients connected. Video pipelines remain stopped.
2025-11-27T04:09:52.312033370Z INFO:data_websocket:Video chunk sender for 'primary' cancelled.
2025-11-27T04:09:52.312063371Z INFO:data_websocket:Video chunk sender for 'primary' finished.
2025-11-27T04:09:52.324664222Z INFO:data_websocket:Reconfiguration process complete (state unlocked).
2025-11-27T04:09:52.331127296Z INFO:data_websocket:Last client (('127.0.0.1', 58834)) disconnected. All pipelines should have been stopped by reconfigure_displays.
2025-11-27T04:09:52.331156735Z INFO:main:Initiating unified pipeline shutdown...
2025-11-27T04:09:52.331189872Z WARNING:data_websocket:Reconfiguration already in progress. Ignoring concurrent request.
2025-11-27T04:09:52.331214672Z INFO:data_websocket:Stopping pcmflux audio pipeline...
2025-11-27T04:09:52.331295976Z INFO:data_websocket:pcmflux audio chunk broadcasting task cancelled.
2025-11-27T04:09:52.331315104Z INFO:data_websocket:pcmflux audio chunk broadcasting task finished.