2025-09-01T03:39:50.244206100Z [migrations] started
2025-09-01T03:39:50.249085244Z [migrations] no migrations found
2025-09-01T03:39:50.949868029Z usermod: no changes
2025-09-01T03:39:51.093376764Z ───────────────────────────────────────
2025-09-01T03:39:51.093415051Z 
2025-09-01T03:39:51.093424320Z       ██╗     ███████╗██╗ ██████╗
2025-09-01T03:39:51.093432867Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-01T03:39:51.093441444Z       ██║     ███████╗██║██║   ██║
2025-09-01T03:39:51.093449661Z       ██║     ╚════██║██║██║   ██║
2025-09-01T03:39:51.093457777Z       ███████╗███████║██║╚██████╔╝
2025-09-01T03:39:51.093466194Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-01T03:39:51.093474411Z 
2025-09-01T03:39:51.093482207Z    Brought to you by linuxserver.io
2025-09-01T03:39:51.093490133Z ───────────────────────────────────────
2025-09-01T03:39:51.105617832Z 
2025-09-01T03:39:51.106007125Z To support LSIO projects visit:
2025-09-01T03:39:51.106038649Z https://www.linuxserver.io/donate/
2025-09-01T03:39:51.106050583Z 
2025-09-01T03:39:51.106061004Z ───────────────────────────────────────
2025-09-01T03:39:51.106072447Z GID/UID
2025-09-01T03:39:51.106594648Z ───────────────────────────────────────
2025-09-01T03:39:51.224293736Z 
2025-09-01T03:39:51.224335860Z User UID:    911
2025-09-01T03:39:51.224345339Z User GID:    911
2025-09-01T03:39:51.224354127Z ───────────────────────────────────────
2025-09-01T03:39:51.254062715Z Linuxserver.io version: 142.0.1-1-ls87
2025-09-01T03:39:51.257759890Z Build-date: 2025-09-01T03:31:28+00:00
2025-09-01T03:39:51.257804179Z ───────────────────────────────────────
2025-09-01T03:39:51.257815211Z     
2025-09-01T03:39:54.181950988Z ..........+......+..+...+....+...+...+...+..+...............+.........+....+..+..........+...+..+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.+...+....+............+..............+....+...+...+..+...+....+..+.+..+.+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*......+...+.........+..................+...+..+......+.+......+..................+..+....+.........+............+........+.+..............+......+...+.+.....+....+..+......+....+......+..............+.+...+..+.......+...............+............+...+.....+......+.........+...+...+.+...........+....+...+...+............+...+...+.........+..+................+...+...........................+..+...+...+......+...+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2025-09-01T03:39:54.423778127Z .+........+...+......+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*...+....+..+....+......+...+..+....+..+...+.......+..+..........+.....+.......+.....+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.............+...........+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2025-09-01T03:39:54.465878346Z -----
2025-09-01T03:39:58.391638674Z [custom-init] No custom files found, skipping...
2025-09-01T03:39:59.001277081Z _XSERVTransmkdir: ERROR: euid != 0,directory /tmp/.X11-unix will not be created.
2025-09-01T03:39:59.012510570Z screen 0 shmid 0
2025-09-01T03:39:59.024925918Z xsettingsd: Loaded 1 setting from /config/.xsettingsd
2025-09-01T03:39:59.071514353Z [ls.io-init] done.
2025-09-01T03:40:00.306344274Z xsettingsd: Created window 0x200001 on screen 0 with timestamp 2899519695
2025-09-01T03:40:00.307446223Z xsettingsd: Selection _XSETTINGS_S0 is owned by 0x0
2025-09-01T03:40:00.307667498Z xsettingsd: Took ownership of selection _XSETTINGS_S0
2025-09-01T03:40:00.625256263Z 17
2025-09-01T03:40:00.875057658Z 18
2025-09-01T03:40:02.217323281Z INFO:data_websocket:pcmflux library found. Audio capture is available.
2025-09-01T03:40:02.704942893Z INFO:data_websocket:pixelflux library found. Striped encoding modes available.
2025-09-01T03:40:03.176746610Z INFO:root:Expected C js_config_t size (from ctypes): 1354 bytes
2025-09-01T03:40:04.264498189Z INFO:main:Upload directory ensured: /config/Desktop
2025-09-01T03:40:04.284294098Z 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-01T03:40:04.284630435Z INFO:main:Initial Encoder: x264enc, Framerate: 60, Bitrate: 16000kbps
2025-09-01T03:40:04.285054258Z INFO:main:SelkiesStreamingApp initialized: encoder=x264enc, display=1024x768
2025-09-01T03:40:04.286114954Z INFO:main:All main components initialized. Running server...
2025-09-01T03:40:04.319094328Z INFO:webrtc_input:System DPI detected as ~96. Cursor size cap set to 32x32px.
2025-09-01T03:40:04.344378327Z INFO:webrtc_input:Resetting keyboard modifiers.
2025-09-01T03:40:04.367900609Z INFO:webrtc_input:Starting clipboard monitor
2025-09-01T03:40:04.386478847Z INFO:webrtc_input:Found XFIXES version 4.0
2025-09-01T03:40:04.386655232Z INFO:webrtc_input:starting cursor monitor
2025-09-01T03:40:04.387103685Z INFO:webrtc_input:watching for cursor changes
2025-09-01T03:40:04.463465128Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-09-01T03:40:04.472284346Z INFO:data_websocket:Data WebSocket Server listening on port 8082
2025-09-01T03:40:05.235020966Z INFO:webrtc_input:Initializing 4 persistent gamepad instances...
2025-09-01T03:40:05.239637702Z 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-01T03:40:05.240040313Z 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-01T03:40:05.240490128Z 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-01T03:40:05.241488960Z 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-01T03:40:05.241748612Z 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-01T03:40:05.242130622Z 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-01T03:40:05.243078290Z 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-01T03:40:05.243380478Z 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-01T03:40:05.243892359Z 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-01T03:40:05.244679885Z 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-01T03:40:05.244976101Z 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-01T03:40:05.245426017Z 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-01T03:40:05.249938894Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js0.sock: Event processor started.
2025-09-01T03:40:05.250697591Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js0.sock
2025-09-01T03:40:05.251646943Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js1.sock: Event processor started.
2025-09-01T03:40:05.252091157Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js1.sock
2025-09-01T03:40:05.253038084Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js2.sock: Event processor started.
2025-09-01T03:40:05.253507308Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js2.sock
2025-09-01T03:40:05.254370677Z INFO:selkies_gamepad:Gamepad /tmp/selkies_js3.sock: Event processor started.
2025-09-01T03:40:05.254865072Z INFO:selkies_gamepad:JS interposer server listening on /tmp/selkies_js3.sock
2025-09-01T03:40:05.256199349Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1000.sock
2025-09-01T03:40:05.256675438Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1001.sock
2025-09-01T03:40:05.256979861Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1002.sock
2025-09-01T03:40:05.257279474Z INFO:selkies_gamepad:EVDEV interposer server listening on /tmp/selkies_event1003.sock
2025-09-01T03:40:12.456119194Z dbus-daemon[861]: [system] Activating service name='org.freedesktop.login1' requested by ':1.10' (uid=911 pid=1446 comm="/qemu/qemu-aarch64 /usr/bin/librewolf") (using servicehelper)
2025-09-01T03:40:12.466616861Z dbus-daemon[861]: [system] Activating service name='org.freedesktop.timedate1' requested by ':1.10' (uid=911 pid=1446 comm="/qemu/qemu-aarch64 /usr/bin/librewolf") (using servicehelper)
2025-09-01T03:40:12.477488290Z dbus-daemon[861]: [system] Activated service 'org.freedesktop.login1' failed: Failed to execute program org.freedesktop.login1: Permission denied
2025-09-01T03:40:35.797699540Z WARNING:data_websocket:Cannot broadcast cursor data: no clients connected or server not ready.
2025-09-01T03:41:15.688450875Z INFO:data_websocket:Data WebSocket connected from ('127.0.0.1', 44964)
2025-09-01T03:41:15.694640157Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1024, "height": 768}
2025-09-01T03:41:15.695618928Z INFO:data_websocket:Sending last known cursor to new client ('127.0.0.1', 44964)
2025-09-01T03:41:15.719672861Z INFO:data_websocket:Attempting to establish PulseAudio connection...
2025-09-01T03:41:15.796369019Z INFO:data_websocket:PulseAudio connection established.
2025-09-01T03:41:15.806038298Z 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-09-01T03:41:15.806373623Z INFO:gst_app_resize:on_resize_handler attempting resize for: 1920x992
2025-09-01T03:41:15.806657765Z INFO:gst_app_resize:App dimensions updated to 1920x992 before xrandr call.
2025-09-01T03:41:15.891918198Z INFO:gst_app_resize:Mode 1920x992 not found in xrandr list. Attempting to add for screen 'screen'.
2025-09-01T03:41:16.040599578Z INFO:gst_app_resize:Successfully ran: xrandr --newmode 1920x992 158.00 1920 2040 2240 2560 992 995 1005 1029 -hsync +vsync
2025-09-01T03:41:16.127915099Z INFO:gst_app_resize:Successfully ran: xrandr --addmode screen 1920x992
2025-09-01T03:41:16.128403803Z INFO:gst_app_resize:Applying xrandr mode '1920x992' for screen 'screen'.
2025-09-01T03:41:16.221887332Z INFO:gst_app_resize:Successfully applied xrandr mode '1920x992'.
2025-09-01T03:41:16.222528654Z INFO:gst_app_resize:resize_display('1920x992') reported success.
2025-09-01T03:41:16.223333644Z INFO:data_websocket:Applying SCALING_DPI from initial settings: 96
2025-09-01T03:41:16.230185030Z INFO:gst_app_resize:Openbox detected. Applying xrdb for DPI 96.
2025-09-01T03:41:16.234007556Z INFO:gst_app_resize:Wrote 'Xft.dpi:   96' to /config/.Xresources.
2025-09-01T03:41:16.269168183Z INFO:data_websocket:Broadcasting stream resolution: {"type": "stream_resolution", "width": 1920, "height": 992}
2025-09-01T03:41:16.664562852Z INFO:gst_app_resize:Successfully loaded /config/.Xresources using xrdb.
2025-09-01T03:41:16.666004154Z INFO:gst_app_resize:Wrote font and DPI settings to /config/.xsettingsd.
2025-09-01T03:41:16.807638165Z INFO:gst_app_resize:Found xsettingsd process with PID: 863.
2025-09-01T03:41:16.872240692Z xsettingsd: Reloading configuration
2025-09-01T03:41:16.874792520Z xsettingsd: Loaded 5 settings from /config/.xsettingsd
2025-09-01T03:41:16.877711888Z INFO:gst_app_resize:Sent SIGHUP to xsettingsd process 863 to reload config.
2025-09-01T03:41:16.878447299Z INFO:data_websocket:Successfully set DPI to 96 from initial settings.
2025-09-01T03:41:16.879406030Z INFO:data_websocket:Attempting to set cursor size to 32 based on initial DPI.
2025-09-01T03:41:17.477700098Z INFO:data_websocket:Successfully set cursor size to 32.
2025-09-01T03:41:17.478315367Z WARNING:data_websocket:Pipeline is inactive for the initial client. Forcing a start.
2025-09-01T03:41:17.478787898Z INFO:data_websocket:Video pipeline for x264enc needs to start (was not active or forced).
2025-09-01T03:41:17.480501759Z INFO:data_websocket:Starting x264enc: 1920x992 @ 60.0fps, CRF: 25, FullFrame: True
2025-09-01T03:41:17.505373749Z 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-09-01T03:41:17.505785799Z INFO:data_websocket:Trying to ensure client_settings_received is set for backpressure task start.
2025-09-01T03:41:17.506430146Z INFO:data_websocket:New frame backpressure task started (current encoder: 'x264enc').
2025-09-01T03:41:17.506901806Z INFO:data_websocket:x264enc capture started successfully.
2025-09-01T03:41:17.507661205Z INFO:data_websocket:Initial client settings message processed by ws_handler.
2025-09-01T03:41:17.508310993Z INFO:data_websocket:Initial setup: Audio pipeline not yet active, attempting start.
2025-09-01T03:41:17.508765498Z INFO:data_websocket:Starting pcmflux audio pipeline...
2025-09-01T03:41:17.510283395Z INFO:data_websocket:pcmflux settings: device='output.monitor', bitrate=320000, channels=2
2025-09-01T03:41:17.512663327Z INFO:data_websocket:Frame-based backpressure logic task started.
2025-09-01T03:41:17.516098032Z INFO:data_websocket:Client settings received, proceeding with backpressure loop.
2025-09-01T03:41:17.520555728Z INFO:data_websocket:pcmflux audio capture started successfully.
2025-09-01T03:41:17.531512610Z [pcmflux] Attempting to connect to PulseAudio device: output.monitor...
2025-09-01T03:41:17.547347935Z INFO:data_websocket:pcmflux audio chunk broadcasting task started.
2025-09-01T03:41:17.559574463Z X Shared Memory Extension available.
2025-09-01T03:41:17.563816253Z XShm setup complete for 1920x992.
2025-09-01T03:41:17.564329727Z CPU cores available: 64
2025-09-01T03:41:17.605815038Z WARNING:webrtc_input:No clipboard content to send
2025-09-01T03:41:17.606846906Z INFO:data_websocket:Received START_VIDEO for encoder: x264enc
2025-09-01T03:41:17.607312233Z INFO:data_websocket:x264enc pipeline is already capturing.
2025-09-01T03:41:17.608841091Z INFO:data_websocket:Received START_AUDIO command from client for server-to-client audio.
2025-09-01T03:41:17.609508044Z INFO:data_websocket:START_AUDIO: pcmflux audio pipeline already active.
2025-09-01T03:41:17.659026259Z [pcmflux] SUCCESS: Connected to PulseAudio.
2025-09-01T03:41:17.666729380Z [pcmflux] SUCCESS: Opus encoder created.
2025-09-01T03:41:17.671174320Z [pcmflux] Capture loop started. Device: output.monitor, Rate: 48000, Channels: 2, Bitrate: 320 kbps, VBR: On, Silence Gate: Off, PCM Chunk: 3840 bytes
2025-09-01T03:41:18.017547353Z INFO:data_websocket:Frame-based backpressure logic task finished.
2025-09-01T03:41:18.703065568Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 6.00 EncStripes/s: 6.00
2025-09-01T03:41:19.638911178Z [pcmflux] First non-silent audio chunk detected! Encoding...
2025-09-01T03:41:19.685680128Z [pcmflux] Status | Read: 1, Silent: 0 (0.0%), Encoded: 1, Rate: 0.01 kbps
2025-09-01T03:41:19.714063888Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-09-01T03:41:20.728791118Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-09-01T03:41:21.686123261Z [pcmflux] Status | Read: 31, Silent: 0 (0.0%), Encoded: 31, Rate: 0.37 kbps
2025-09-01T03:41:21.748045271Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-09-01T03:41:22.762503058Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-09-01T03:41:23.686604812Z [pcmflux] Status | Read: 109, Silent: 0 (0.0%), Encoded: 109, Rate: 1.31 kbps
2025-09-01T03:41:23.778930079Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-09-01T03:41:24.798175676Z Res: 1920x992 Mode: H264 (CPU) CS_IN:I420 LR FF Stripes: 1 CRF:25 EncFPS: 0.00 EncStripes/s: 0.00
2025-09-01T03:41:25.686785187Z [pcmflux] Status | Read: 99, Silent: 0 (0.0%), Encoded: 99, Rate: 1.19 kbps
2025-09-01T03:41:25.749247355Z INFO:data_websocket:Cleaning up Data WS handler for ('127.0.0.1', 44964)...
2025-09-01T03:41:25.760190288Z INFO:data_websocket:No other clients in set after ('127.0.0.1', 44964) disconnected. Marking pipelines for stop.
2025-09-01T03:41:25.760804275Z INFO:data_websocket:Stopping global pipelines due to last client disconnect (('127.0.0.1', 44964)).
2025-09-01T03:41:25.761137966Z INFO:main:Initiating unified pipeline shutdown...
2025-09-01T03:41:25.772571047Z INFO:main:Queueing x264-striped capture stop.
2025-09-01T03:41:25.773148790Z INFO:main:Queueing pcmflux audio capture stop.
2025-09-01T03:41:25.776983531Z [pcmflux] Stop requested. Cleaning up capture loop...
2025-09-01T03:41:25.777315039Z INFO:main:Waiting for 2 capture module(s) to stop...
2025-09-01T03:41:25.785010544Z [pcmflux] Audio capture loop finished. Resources released.