2025-09-22T03:29:21.891624805Z [migrations] started
2025-09-22T03:29:21.900032024Z [migrations] no migrations found
2025-09-22T03:29:23.400506968Z usermod: no changes
2025-09-22T03:29:23.568715337Z ───────────────────────────────────────
2025-09-22T03:29:23.568760347Z 
2025-09-22T03:29:23.568769927Z       ██╗     ███████╗██╗ ██████╗
2025-09-22T03:29:23.568779205Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-22T03:29:23.568788294Z       ██║     ███████╗██║██║   ██║
2025-09-22T03:29:23.568796891Z       ██║     ╚════██║██║██║   ██║
2025-09-22T03:29:23.568805648Z       ███████╗███████║██║╚██████╔╝
2025-09-22T03:29:23.568814386Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-22T03:29:23.568823144Z 
2025-09-22T03:29:23.568831621Z    Brought to you by linuxserver.io
2025-09-22T03:29:23.568840148Z ───────────────────────────────────────
2025-09-22T03:29:23.579473629Z 
2025-09-22T03:29:23.579816760Z To support LSIO projects visit:
2025-09-22T03:29:23.579864516Z https://www.linuxserver.io/donate/
2025-09-22T03:29:23.579880699Z 
2025-09-22T03:29:23.579891200Z ───────────────────────────────────────
2025-09-22T03:29:23.579900830Z GID/UID
2025-09-22T03:29:23.580399804Z ───────────────────────────────────────
2025-09-22T03:29:23.691545523Z 
2025-09-22T03:29:23.691594712Z User UID:    911
2025-09-22T03:29:23.691604492Z User GID:    911
2025-09-22T03:29:23.691612849Z ───────────────────────────────────────
2025-09-22T03:29:23.740836644Z Linuxserver.io version: 143.0-1-ls91
2025-09-22T03:29:23.744851338Z Build-date: 2025-09-22T03:19:40+00:00
2025-09-22T03:29:23.744888784Z ───────────────────────────────────────
2025-09-22T03:29:23.744902281Z     
2025-09-22T03:29:26.323314453Z ..+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*..+......+...........+.+...+..+.........+...+.............+..+.......+......+..+.+......+.....+.+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*..+.....+...+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2025-09-22T03:29:27.309210390Z .........................+..+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*...+..................+.+.........+.....+.+.....+......+.+.........+..................+.................+.+...+..+...+............+.............+......+........+......+.......+..+.......+.....+......+...+.+......+.....+...+......+.+..............+.+...+...........+.............+.....+.+......+...+..+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2025-09-22T03:29:27.354397848Z -----
2025-09-22T03:29:33.142047564Z [custom-init] No custom files found, skipping...
2025-09-22T03:29:34.088648338Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-09-22T03:29:34.106647881Z screen 0 shmid 0
2025-09-22T03:29:34.381072273Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-09-22T03:29:34.436942752Z [ls.io-init] done.
2025-09-22T03:29:35.462322333Z xsettingsd: Created window 0x400001 on screen 0 with timestamp 418327556
2025-09-22T03:29:35.462921599Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-09-22T03:29:35.463032693Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-09-22T03:29:36.236195819Z 17
2025-09-22T03:29:36.631935206Z 18
2025-09-22T03:29:38.338079592Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-09-22T03:29:38.884650019Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-09-22T03:29:39.426457004Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-09-22T03:29:40.575401410Z INFO:main:Upload directory ensured: /config/Desktop
2025-09-22T03:29:40.593018624Z 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-09-22T03:29:40.593417848Z INFO:main:Initial Encoder: x264enc, Framerate: 60, Bitrate: 16000kbps
2025-09-22T03:29:40.593789947Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-09-22T03:29:40.594941426Z INFO:main:All main components initialized. Running server...
2025-09-22T03:29:40.632335751Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-09-22T03:29:40.660853785Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-09-22T03:29:40.685987954Z INFO:webrtc_input:Clipboard monitor running (binary mode: False)
2025-09-22T03:29:40.705323357Z INFO:webrtc_input:Found XFIXES version 4.0
2025-09-22T03:29:40.705520444Z INFO:webrtc_input:starting cursor monitor
2025-09-22T03:29:40.705962073Z INFO:webrtc_input:watching for cursor changes
2025-09-22T03:29:40.792143405Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-09-22T03:29:40.801657583Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-09-22T03:29:41.975270902Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-09-22T03:29:41.977983063Z 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-09-22T03:29:41.978216173Z 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-09-22T03:29:41.978518070Z 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-09-22T03:29:41.979132568Z 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-09-22T03:29:41.979332701Z 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-09-22T03:29:41.979588195Z 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-09-22T03:29:41.980318566Z 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-09-22T03:29:41.980534150Z 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-09-22T03:29:41.980790997Z 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-09-22T03:29:41.981846132Z 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-09-22T03:29:41.982065273Z 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-09-22T03:29:41.982334535Z 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-09-22T03:29:41.984894370Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-09-22T03:29:41.985392713Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-09-22T03:29:41.986023263Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-09-22T03:29:41.986322145Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-09-22T03:29:41.986974218Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-09-22T03:29:41.987273109Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-09-22T03:29:41.987878869Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-09-22T03:29:41.988179905Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-09-22T03:29:41.989056991Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-09-22T03:29:41.989395994Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-09-22T03:29:41.989703173Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-09-22T03:29:41.990035221Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-09-22T03:29:50.205708607Z dbus-daemon[868]: [system] Activating service name='org.freedesktop.login1' requested by ':1.10' (uid=911 pid=1443 comm="/qemu/qemu-aarch64 /usr/bin/librewolf") (using servicehelper)
2025-09-22T03:29:50.237167532Z dbus-daemon[868]: [system] Activating service name='org.freedesktop.timedate1' requested by ':1.10' (uid=911 pid=1443 comm="/qemu/qemu-aarch64 /usr/bin/librewolf") (using servicehelper)
2025-09-22T03:29:50.237187281Z dbus-daemon[868]: [system] Activated service 'org.freedesktop.login1' failed: Failed to execute program org.freedesktop.login1: Permission denied
2025-09-22T03:30:15.282892071Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-09-22T03:30:18.432856007Z WARNING:webrtc_input:Error reading clipboard with xclip: 
2025-09-22T03:30:45.239378449Z WARNING:webrtc_input:Error reading clipboard with xclip: 
2025-09-22T03:30:49.424265587Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 59258)
2025-09-22T03:30:49.425189377Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 59258)
2025-09-22T03:30:49.449023239Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-09-22T03:30:49.522708540Z INFO:data_websocket:PulseAudio connection established.
2025-09-22T03:30:49.532001271Z INFO:data_websocket:Registering new client for display: primary
2025-09-22T03:30:49.532384483Z INFO:data_websocket:Applying client settings for 'primary' (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, 'enableBinaryClipboard': False, 'displayId': 'primary', 'displayPosition': 'right'}
2025-09-22T03:30:49.535408101Z INFO:gst_app_resize:Openbox detected. Applying xrdb for DPI 96.
2025-09-22T03:30:49.537315592Z INFO:gst_app_resize:Wrote 'Xft.dpi:   96' to /config/.Xresources.
2025-09-22T03:30:50.608519631Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-09-22T03:30:50.609938287Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-09-22T03:30:50.754901241Z INFO:gst_app_resize:Found xsettingsd process with PID: 864.
2025-09-22T03:30:50.807713452Z xsettingsd: Reloading configuration
2025-09-22T03:30:50.810301984Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-09-22T03:30:50.813252475Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 864 to reload config.
2025-09-22T03:30:51.600572012Z WARNING:data_websocket:Pipeline is inactive for the initial client. Forcing a start.
2025-09-22T03:30:51.601012509Z INFO:data_websocket:Client settings for 'primary' or resolution changed, triggering full display reconfiguration.
2025-09-22T03:30:51.603550539Z INFO:data_websocket:Calculating new extended desktop layout from ALL clients...
2025-09-22T03:30:51.604395230Z INFO:data_websocket:Layout calculated: Total Size=1920x992. Layouts: {'primary': {'x': 0, 'y': 0, 'w': 1920, 'h': 992}}
2025-09-22T03:30:51.874642974Z INFO:data_websocket:Mode 1920x992 not found. Creating it.
2025-09-22T03:30:52.208902550Z INFO:data_websocket:Defining logical monitors for the window manager...
2025-09-22T03:30:52.451068970Z INFO:data_websocket:Starting separate capture instances for each ACTIVE display region...
2025-09-22T03:30:52.451564057Z INFO:data_websocket:Client 'primary' is active. Starting its capture.
2025-09-22T03:30:52.452071810Z INFO:data_websocket:Preparing to start capture for display='primary': Res=1920x992, Offset=0x0
2025-09-22T03:30:52.469224217Z INFO:data_websocket:Video chunk sender started for display 'primary'.
2025-09-22T03:30:52.476912959Z INFO:data_websocket:SUCCESS: Capture started for 'primary'.
2025-09-22T03:30:52.477571796Z INFO:data_websocket:New frame backpressure task started for display 'primary'.
2025-09-22T03:30:52.478292747Z INFO:data_websocket:Broadcasting primary stream resolution to all clients: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-09-22T03:30:52.479665462Z INFO:data_websocket:Broadcasting display config update: DISPLAY_CONFIG_UPDATE,{"type": "display_config_update", "displays": ["primary"]}
2025-09-22T03:30:52.480794395Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-09-22T03:30:52.481407108Z INFO:data_websocket:Initial setup: Primary client connected, audio not active, attempting start.
2025-09-22T03:30:52.481821413Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-09-22T03:30:52.483518840Z INFO:data_websocket:pcmflux settings: device='output.monitor', bitrate=320000, channels=2
2025-09-22T03:30:52.486631578Z INFO:data_websocket:Frame-based backpressure logic task started for display 'primary'.
2025-09-22T03:30:52.490327801Z INFO:data_websocket:Client settings received, proceeding with backpressure loop for 'primary'.
2025-09-22T03:30:52.499669711Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-09-22T03:30:52.510380719Z [pcmflux] Attempting to connect to PulseAudio device: output.monitor...
2025-09-22T03:30:52.520126954Z X Shared Memory Extension available.
2025-09-22T03:30:52.522507738Z XShm setup complete for 1920x992.
2025-09-22T03:30:52.522926321Z CPU cores available: 64
2025-09-22T03:30:52.524993804Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-09-22T03:30:52.528340743Z 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-09-22T03:30:52.604841733Z INFO:data_websocket:Received START_VIDEO for 'primary'. Starting stream without reconfiguring layout.
2025-09-22T03:30:52.605306028Z WARNING:data_websocket:Capture instance for 'primary' already exists. Skipping start.
2025-09-22T03:30:52.606084095Z INFO:data_websocket:Backpressure logic task for 'primary' cancelled.
2025-09-22T03:30:52.606552648Z INFO:data_websocket:Backpressure logic task for 'primary' finished.
2025-09-22T03:30:52.608617817Z INFO:data_websocket:Backpressure task for 'primary' was stopped. Resetting its frame IDs.
2025-09-22T03:30:52.609020908Z INFO:data_websocket:Resetting frame IDs for display 'primary'.
2025-09-22T03:30:52.609447167Z INFO:data_websocket:Broadcasting primary pipeline reset to all 1 clients: PIPELINE_RESETTING primary
2025-09-22T03:30:52.610611060Z INFO:data_websocket:New frame backpressure task started for display 'primary'.
2025-09-22T03:30:52.611561544Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-09-22T03:30:52.611998464Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-09-22T03:30:52.612582500Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-09-22T03:30:52.613694529Z INFO:data_websocket:Frame-based backpressure logic task started for display 'primary'.
2025-09-22T03:30:52.614111448Z INFO:data_websocket:Client settings received, proceeding with backpressure loop for 'primary'.
2025-09-22T03:30:52.617253525Z [pcmflux] SUCCESS: Opus encoder created.
2025-09-22T03:30:52.622983082Z [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-09-22T03:30:54.592872451Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-09-22T03:30:59.504365809Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 59258) (Display ID: primary)...
2025-09-22T03:30:59.505213606Z INFO:data_websocket:Client for primary removed. Triggering display reconfiguration.
2025-09-22T03:30:59.505656227Z INFO:data_websocket:Stopping all existing capture and backpressure tasks...
2025-09-22T03:30:59.529366991Z Capture loop stopped. X resources released.
2025-09-22T03:30:59.533375843Z INFO:data_websocket:All capture instances, senders, and backpressure tasks stopped.
2025-09-22T03:30:59.533833284Z WARNING:data_websocket:No display clients connected. Video pipelines remain stopped.