Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z DEBUG: MPV log file: C:\Forgejo\Medios-Macina\Log\medeia-mpv.log DEBUG: Named pipe not available yet: \\.\pipe\mpv-medios-macina DEBUG: Named pipe not available yet: \\.\pipe\mpv-medios-macina MPV log file: C:\Forgejo\Medios-Macina\Log\medeia-mpv.log DEBUG: Named pipe not available yet: \\.\pipe\mpv-medios-macina DEBUG: Named pipe not available yet: \\.\pipe\mpv-medios-macina MPV log (tail): [ 34.120][d][ao/wasapi] Fixing format [ 34.120][d][ao/wasapi] IAudioClient::GetDevicePeriod [ 34.121][v][ao/wasapi] Device period: default 10000 us, minimum 3000 us [ 34.121][d][ao/wasapi] IAudioClient::Initialize [ 34.134][d][ao/wasapi] IAudioClient::Initialize pRenderClient [ 34.134][d][ao/wasapi] IAudioClient::Initialize IAudioClient_SetEventHandle [ 34.134][d][ao/wasapi] IAudioClient::Initialize IAudioClient_GetBufferSize [ 34.134][v][ao/wasapi] Buffer frame count: 1056 (22000 us) [ 34.134][v][ao/wasapi] IAudioClock::GetFrequency gave a frequency of 384000. [ 34.136][d][ao/wasapi] IAudioClient::Initialize pAudioVolume [ 34.136][d][ao/wasapi] Entering dispatch loop [ 34.136][d][ao/wasapi] Init wasapi done [ 34.136][v][ao/wasapi] device buffer: 1056 samples. [ 34.136][v][ao/wasapi] using soft-buffer of 9600 samples. [ 34.136][i][cplayer] AO: [wasapi] 48000Hz stereo 2ch float [ 34.136][v][cplayer] AO: Description: Windows WASAPI audio output (event mode) [ 34.136][v][autoconvert] inserting resampler [ 34.136][v][swresample] format change, reinitializing resampler [ 34.136][v][swresample] 44100Hz stereo floatp -> 48000Hz stereo float [ 34.137][v][af] [out] 48000Hz stereo 2ch float [ 34.139][v][cplayer] audio ready [ 34.139][v][cplayer] starting audio playback [ 34.139][d][ao/wasapi] Thread Resume [ 34.139][d][ao/wasapi] Thread Reset [ 34.139][d][ao/wasapi] Thread Pause [ 34.139][d][ao/wasapi] Thread Unpause [ 34.139][v][cplayer] playback restart complete @ 0.000000, audio=playing, video=eof [ 34.140][v][cplayer] Set property: user-data/medeia-pipeline-response="" -> 1 [ 34.141][v][cplayer] Set property: user-data/medeia-pipeline-request="{\"data\":{\"url\":\"https://www.youtube.com/watch?v=dQw4w9WgXcQ\"},\"op\":\"ytdlp-formats\",\"id\":\"34082-728967\"}" -> 1 [ 34.148][d][timeline] stream 0: resize index to 256 [ 34.173][v][lavf] EOF reached. [ 34.173][v][timeline] EOF reached. [ 35.393][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 35.393][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 35.393][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 35.399][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 35.399][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 35.399][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 35.484][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 35.484][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 35.484][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 35.490][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 35.490][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 35.490][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 35.962][v][ipc_33] Client connected [ 35.963][v][cplayer] Set property: options/log-file="C:\\Forgejo\\Medios-Macina\\Log\\medeia-mpv.log" -> 1 [ 35.965][v][ipc_33] Client disconnected [ 35.965][d][ipc_33] Destroying client handle... [ 35.966][v][ipc_34] Client connected [ 35.967][v][cplayer] Set property: options/msg-level="all=v" -> 1 [ 35.969][v][ipc_34] Client disconnected [ 35.969][d][ipc_34] Destroying client handle... [ 35.970][v][ipc_35] Client connected [ 35.971][i][cplayer] medeia: log enabled -> C:\Forgejo\Medios-Macina\Log\medeia-mpv.log [ 35.972][v][ipc_35] Client disconnected [ 35.972][d][ipc_35] Destroying client handle... [ 35.973][v][ipc_36] Client connected [ 35.973][v][ipc_36] Client disconnected [ 35.973][v][ipc_37] Client connected [ 35.973][d][ipc_36] Destroying client handle... [ 35.974][v][cplayer] Set property: options/log-file="C:\\Forgejo\\Medios-Macina\\Log\\medeia-mpv.log" -> 1 [ 35.975][v][ipc_37] Client disconnected [ 35.975][d][ipc_37] Destroying client handle... [ 35.975][v][ipc_38] Client connected [ 35.977][v][cplayer] Set property: options/msg-level="all=v" -> 1 [ 35.978][v][ipc_38] Client disconnected [ 35.979][d][ipc_38] Destroying client handle... [ 35.980][v][ipc_39] Client connected [ 35.981][v][cplayer] Set property: options/log-file="C:\\Forgejo\\Medios-Macina\\Log\\medeia-mpv.log" -> 1 [ 35.983][v][ipc_39] Client disconnected [ 35.983][d][ipc_39] Destroying client handle... [ 35.984][v][ipc_40] Client connected [ 35.985][v][cplayer] Set property: options/msg-level="all=v" -> 1 [ 35.986][v][ipc_40] Client disconnected [ 35.986][d][ipc_40] Destroying client handle... [ 35.986][v][ipc_41] Client connected [ 35.987][i][cplayer] medeia: log enabled -> C:\Forgejo\Medios-Macina\Log\medeia-mpv.log [ 35.989][v][ipc_41] Client disconnected [ 35.989][d][ipc_41] Destroying client handle... [ 36.180][d][cplayer] Run command: cycle, flags=73, args=[name="pause", value="1.000000"] [ 36.180][v][cplayer] Set property: pause -> 1 [ 36.180][d][ao/wasapi] Thread Pause [ 37.104][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 37.104][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 37.104][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 37.576][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 37.583][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 37.583][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 38.287][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 38.287][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 38.287][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 38.693][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 38.693][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 38.693][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 38.965][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 38.965][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 38.965][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 38.984][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 38.990][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 38.990][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 39.098][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 39.098][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 39.105][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 39.112][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 39.112][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 39.112][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 41.106][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 41.106][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 41.106][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 41.115][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 41.122][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 41.122][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 42.198][d][cplayer] Run command: begin-vo-dragging, flags=73, args=[] [ 42.814][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 42.814][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 42.828][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 42.828][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 42.835][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 42.835][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_right", flags="allow-hide-cursor+allow-vo-dragging"] [ 42.835][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 42.835][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 42.856][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 42.856][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_right"] [ 42.856][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 42.856][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 44.274][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 44.274][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_right", flags="allow-hide-cursor+allow-vo-dragging"] [ 44.274][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 44.274][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 44.283][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 44.283][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_right"] [ 44.283][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 44.283][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 44.297][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 44.297][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 44.297][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 44.305][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 44.305][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 44.305][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 45.258][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 45.258][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 45.258][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 45.264][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 45.270][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 45.271][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 46.370][d][cplayer] Run command: begin-vo-dragging, flags=73, args=[] [ 48.743][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 48.744][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 50.556][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 50.556][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 50.682][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 50.682][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 50.696][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 50.696][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 50.710][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 50.710][d][cplayer] Run command: enable-section, flags=64, args=[name="wheel", flags="allow-hide-cursor+allow-vo-dragging"] [ 50.710][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 50.786][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left_dbl"] [ 50.786][d][cplayer] Run command: disable-section, flags=64, args=[name="wheel"] [ 50.786][d][cplayer] Run command: disable-section, flags=64, args=[name="mbtn_left"] [ 52.125][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left_dbl", flags=""] [ 52.125][d][cplayer] Run command: enable-section, flags=64, args=[name="mbtn_left", flags=""] [ 52.788][d][cplayer] Run command: script-binding, flags=73, args=[name="uosc/__keybinding1", arg=""] [ 52.789][d][cplayer] Run command: quit, flags=73, args=[code="0"] [ 52.789][v][cplayer] EOF code: 5 [ 52.789][d][ad] Uninit decoder. [ 52.789][d][ao/wasapi] Thread Reset [ 52.789][d][ao/wasapi] Thread Pause [ 52.790][d][cplayer] Terminating demuxers... [ 52.791][d][ffmpeg] AVIOContext: Statistics: 1300631 bytes read, 0 seeks [ 52.791][d][cplayer] Done terminating demuxers. [ 52.791][v][cplayer] finished playback, success (reason 3) [ 52.791][v][cplayer] Running hook: ytdl_hook/on_after_end_file [ 52.792][v][auto_profiles] Re-evaluating auto profile manga [ 52.793][v][auto_profiles] Re-evaluating auto profile loop-short [ 52.793][d][cplayer] Run command: del, flags=64, args=[name="user-data/mpv/ytdl/json-subprocess-result"] [ 52.793][i][cplayer] Exiting... (Quit) [ 52.794][d][cplayer] Run command: del, flags=64, args=[name="user-data/mpv/console"] [ 52.794][d][ipc_8] Destroying client handle... [ 52.794][d][positioning] Destroying client handle... [ 52.794][d][commands] Destroying client handle... [ 52.794][d][select] Destroying client handle... [ 52.794][d][ipc_3] Destroying client handle... [ 52.794][d][ipc_32] Destroying client handle... [ 52.794][d][cplayer] Run command: keybind, flags=64, args=[name="q", cmd="quit", comment=""] [ 52.794][d][console] Destroying client handle... [ 52.794][d][auto_profiles] Destroying client handle... [ 52.795][d][stats] Destroying client handle... [ 52.796][d][main] Destroying client handle... [ 52.796][d][ytdl_hook] Destroying client handle... [ 52.798][d][uosc] Destroying client handle... [ 52.799][d][SystemMediaTransportControls] Destroying client handle... [ 52.805][d][ao/wasapi] Uninit wasapi [ 52.805][d][ao/wasapi] Thread Reset [ 52.805][d][ao/wasapi] Thread Pause [ 52.805][d][ao/wasapi] Thread shutdown [ 52.805][d][ao/wasapi] Thread uninit done [ 52.805][d][ao/wasapi] Thread return [ 52.806][d][ao/wasapi] Uninit wasapi done [ 52.851][v][vo/gpu-next/win32] uninit Helper logs from database (mpv module, most recent first): [ERROR] Load URL pipeline failed: timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [WARN] Load URL still processing after 5 seconds [INFO] [mpv error] ytdl_hook ERROR: Unsupported URL: https://example.com/ [INFO] [mpv error] ytdl_hook youtube-dl failed: unexpected error occurred [INFO] [mpv error] cplayer Failed to recognize file format. [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [mpv error] vo/gpu-next/libplacebo Failed creating FBO texture! Disabling advanced rendering.. [INFO] [mpv error] vo/gpu-next/libplacebo Failed dispatching scaler.. disabling [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [mpv] (previous line repeated 4x) [INFO] [mpv warn] input No key binding found for key ';'. [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [mpv] (previous line repeated 2x) [INFO] [mpv] (previous line repeated 4x) [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [mpv] (previous line repeated 4x) [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [mpv] (previous line repeated 2x) [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [mpv] (previous line repeated 3x) [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [mpv] (previous line repeated 3x) [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [mpv] (previous line repeated 4x) [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [mpv warn] input No key binding found for key 'MBTN_RIGHT_DBL'. [INFO] [helper] version=2025-12-19 started ipc=\\.\pipe\mpv-medios-macina [INFO] [helper] file=C:\Forgejo\Medios-Macina\MPV\pipeline_helper.py cwd=C:\Forgejo\Medios-Macina [INFO] [helper] config_root=C:\Forgejo\Medios-Macina exists=False [INFO] [helper] requested mpv log messages level=warn [INFO] [helper] ready heartbeat armed prop=user-data/medeia-pipeline-ready [INFO] [py] Loaded config from medios.db: providers=4 (alldebrid, soulseek, matrix, [INFO] [py] telegram), stores=2 (hydrusnetwork, debrid), mtime=2026-02-02T02:46:41.638481Z [INFO] [py] DEBUG: config_dir=C:\Forgejo\Medios-Macina choices=2 [INFO] [helper] startup store-choices count=2 items=local, rpi [INFO] [helper] published store-choices to user-data/medeia-store-choices-cached [INFO] [helper] published config temp to user-data/medeia-config-temp=C:\Users\Admin\AppData\Local\Temp [INFO] [helper] connected to ipc=\\.\pipe\mpv-medios-macina [INFO] [mpv] (previous line repeated 3x) Helper log file: C:\Forgejo\Medios-Macina\Log\medeia-mpv-helper.log Helper log (tail): [lua] [2026-02-04 16:56:11] medeia lua loaded version=2025-12-24 script=main [lua] [2026-02-04 16:56:11] medeia-lua loaded version=2025-12-24 [lua] [2026-02-04 16:56:11] stores: cache_read cached_json=nil len=0 [lua] [2026-02-04 16:56:11] stores: cache_empty cached_json=nil [lua] [2026-02-04 16:56:11] stores: requesting store-choices via helper (fallback) [lua] [2026-02-04 16:56:11] stores: failed to load store choices via helper; success=false choices_type=nil stderr= error=helper not running [lua] [2026-02-04 16:56:12] [KEY] attempting to re-register mbtn_right after UOSC loaded [lua] [2026-02-04 16:56:26] [input.conf] medios-show-menu called [lua] [2026-02-04 16:56:26] [MENU] M.show_menu called [lua] [2026-02-04 16:56:26] [MENU] Built 6 menu items [lua] [2026-02-04 16:56:26] [MENU] ensure_uosc_loaded returned: true [lua] [2026-02-04 16:56:26] [MENU] Sending menu JSON to uosc: {"title":"Medios Macina","items":[{"title":"Load URL","value":"script-message medios-load-url"},{"value":"script-binding medios-info","title":"Get Metadata","hint":"Ctrl+i"},{"value":"script-binding m... [lua] [2026-02-04 16:56:26] [MENU] Menu command sent successfully [lua] [2026-02-04 16:56:27] medios-load-url handler called [lua] [2026-02-04 16:56:27] medios-load-url: closing main menu before opening Load URL prompt [lua] [2026-02-04 16:56:27] open_load_url_prompt called [lua] [2026-02-04 16:56:27] open_load_url_prompt: sending menu to uosc [lua] [2026-02-04 16:56:33] [LOAD-URL] Event handler called with: {"type":"search","query":"https://www.youtube.com/watch?v=3IpPonmYx3g","menu_id":"{root}"} [lua] [2026-02-04 16:56:33] [LOAD-URL] Parsed event: type=search, query=https://www.youtube.com/watch?v=3IpPonmYx3g [lua] [2026-02-04 16:56:33] [LOAD-URL] Trimmed URL: "https://www.youtube.com/watch?v=3IpPonmYx3g" [lua] [2026-02-04 16:56:33] [INFO] Load URL started: https://www.youtube.com/watch?v=3IpPonmYx3g [lua] [2026-02-04 16:56:33] [LOAD-URL] Starting to load: https://www.youtube.com/watch?v=3IpPonmYx3g [lua] [2026-02-04 16:56:33] [LOAD-URL] Checking if URL can be loaded directly: false [lua] [2026-02-04 16:56:33] [LOAD-URL] URL requires pipeline helper for processing [lua] [2026-02-04 16:56:33] [LOAD-URL] Pipeline helper ready: true [lua] [2026-02-04 16:56:33] [LOAD-URL] Sending to pipeline: .mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play [lua] [2026-02-04 16:56:33] [LOAD-URL] Pipeline helper ready: true [lua] [2026-02-04 16:56:33] M.run_pipeline called with cmd: .mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play [lua] [2026-02-04 16:56:34] ipc-async: send request id=22550-814785 cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play [lua] [2026-02-04 16:56:35] [LOAD-URL] Event handler called with: {"type":"close"} [lua] [2026-02-04 16:56:35] [LOAD-URL] Parsed event: type=close, query=nil [lua] [2026-02-04 16:56:35] [LOAD-URL] Event type is not search: close [lua] [2026-02-04 16:56:35] [LOAD-URL] Closing menu due to type mismatch [lua] [2026-02-04 16:56:38] [WARN] Load URL still processing after 5 seconds [lua] [2026-02-04 16:56:38] [LOAD-URL] Timeout message shown (helper still processing) [lua] [2026-02-04 16:56:44] M.run_pipeline callback fired: resp=nil, err=timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [lua] [2026-02-04 16:56:44] pipeline failed cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play err=timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [lua] [2026-02-04 16:56:44] [LOAD-URL] Pipeline callback received: resp=nil, err=timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [lua] [2026-02-04 16:56:44] [LOAD-URL] Pipeline error: timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [lua] [2026-02-04 16:56:44] [ERROR] Load URL pipeline failed: timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [lua] [2026-02-04 16:56:44] [LOAD-URL] Closing menu [lua] [2026-02-04 16:56:44] [LOAD-URL] Sending close-menu command to UOSC [lua] [2026-02-04 16:56:45] ipc-async: send request id=34082-728967 op=ytdlp-formats Lua log file: C:\Forgejo\Medios-Macina\Log\medeia-mpv-lua.log Lua log (tail): [2026-02-04 16:56:11] medeia lua loaded version=2025-12-24 script=main [2026-02-04 16:56:11] medeia-lua loaded version=2025-12-24 [2026-02-04 16:56:11] stores: cache_read cached_json=nil len=0 [2026-02-04 16:56:11] stores: cache_empty cached_json=nil [2026-02-04 16:56:11] stores: requesting store-choices via helper (fallback) [2026-02-04 16:56:11] stores: failed to load store choices via helper; success=false choices_type=nil stderr= error=helper not running [2026-02-04 16:56:12] [KEY] attempting to re-register mbtn_right after UOSC loaded [2026-02-04 16:56:26] [input.conf] medios-show-menu called [2026-02-04 16:56:26] [MENU] M.show_menu called [2026-02-04 16:56:26] [MENU] Built 6 menu items [2026-02-04 16:56:26] [MENU] ensure_uosc_loaded returned: true [2026-02-04 16:56:26] [MENU] Sending menu JSON to uosc: {"title":"Medios Macina","items":[{"title":"Load URL","value":"script-message medios-load-url"},{"value":"script-binding medios-info","title":"Get Metadata","hint":"Ctrl+i"},{"value":"script-binding m... [2026-02-04 16:56:26] [MENU] Menu command sent successfully [2026-02-04 16:56:27] medios-load-url handler called [2026-02-04 16:56:27] medios-load-url: closing main menu before opening Load URL prompt [2026-02-04 16:56:27] open_load_url_prompt called [2026-02-04 16:56:27] open_load_url_prompt: sending menu to uosc [2026-02-04 16:56:33] [LOAD-URL] Event handler called with: {"type":"search","query":"https://www.youtube.com/watch?v=3IpPonmYx3g","menu_id":"{root}"} [2026-02-04 16:56:33] [LOAD-URL] Parsed event: type=search, query=https://www.youtube.com/watch?v=3IpPonmYx3g [2026-02-04 16:56:33] [LOAD-URL] Trimmed URL: "https://www.youtube.com/watch?v=3IpPonmYx3g" [2026-02-04 16:56:33] [INFO] Load URL started: https://www.youtube.com/watch?v=3IpPonmYx3g [2026-02-04 16:56:33] [LOAD-URL] Starting to load: https://www.youtube.com/watch?v=3IpPonmYx3g [2026-02-04 16:56:33] [LOAD-URL] Checking if URL can be loaded directly: false [2026-02-04 16:56:33] [LOAD-URL] URL requires pipeline helper for processing [2026-02-04 16:56:33] [LOAD-URL] Pipeline helper ready: true [2026-02-04 16:56:33] [LOAD-URL] Sending to pipeline: .mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play [2026-02-04 16:56:33] [LOAD-URL] Pipeline helper ready: true [2026-02-04 16:56:33] M.run_pipeline called with cmd: .mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play [2026-02-04 16:56:34] ipc-async: send request id=22550-814785 cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play [2026-02-04 16:56:35] [LOAD-URL] Event handler called with: {"type":"close"} [2026-02-04 16:56:35] [LOAD-URL] Parsed event: type=close, query=nil [2026-02-04 16:56:35] [LOAD-URL] Event type is not search: close [2026-02-04 16:56:35] [LOAD-URL] Closing menu due to type mismatch [2026-02-04 16:56:38] [WARN] Load URL still processing after 5 seconds [2026-02-04 16:56:38] [LOAD-URL] Timeout message shown (helper still processing) [2026-02-04 16:56:44] M.run_pipeline callback fired: resp=nil, err=timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [2026-02-04 16:56:44] pipeline failed cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play err=timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [2026-02-04 16:56:44] [LOAD-URL] Pipeline callback received: resp=nil, err=timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [2026-02-04 16:56:44] [LOAD-URL] Pipeline error: timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [2026-02-04 16:56:44] [ERROR] Load URL pipeline failed: timeout waiting response (cmd=.mpv -url "https://www.youtube.com/watch?v=3IpPonmYx3g" -play) [2026-02-04 16:56:44] [LOAD-URL] Closing menu [2026-02-04 16:56:44] [LOAD-URL] Sending close-menu command to UOSC [2026-02-04 16:56:45] ipc-async: send request id=34082-728967 op=ytdlp-formats