goyimnose/Medios-Macina
1
0
Fork 0
Code Issues Pull Requests Packages Releases 1 Wiki Activity

f

Browse Source
This commit is contained in:
Nose
2026-02-04 16:59:04 -08:00
parent cd0346489f
commit 37701cea48
6 changed files with 642 additions and 6 deletions
Download Patch File Download Diff File Expand all files Collapse all files

2
API/data/alldebrid.json
View File

@@ -353,7 +353,7 @@
"filedot\\.(xyz|to|top)/([0-9a-zA-Z]{12})"
],
"regexp": "filedot\\.(xyz|to|top)/([0-9a-zA-Z]{12})",
"status": false
"status": true
},
"filefactory": {
"name": "filefactory",

121
MPV/LUA/main.lua
View File

@@ -145,6 +145,81 @@ end
_lua_log('medeia lua loaded version=' .. tostring(MEDEIA_LUA_VERSION) .. ' script=' .. tostring(mp.get_script_name()))
-- Log to database (logs.db) for centralized error/message tracking
-- This ensures all OSD messages and errors are persisted for debugging
local function _log_to_db(level, message)
message = tostring(message or ''):gsub('"', '\\"')
level = tostring(level or 'INFO'):upper()
-- Find the repo root by looking for CLI.py upwards from script directory
local repo_root = ''
do
local script_dir = mp.get_script_directory() or utils.getcwd() or ''
if script_dir ~= '' then
local function find_up(start_dir, relative_path, max_levels)
local d = start_dir
local levels = max_levels or 6
for _ = 0, levels do
if d and d ~= '' then
local candidate = d .. '/' .. relative_path
if utils.file_info(candidate) then
return candidate
end
end
local parent = d and d:match('(.*)[/\\]') or nil
if not parent or parent == d or parent == '' then
break
end
d = parent
end
return nil
end
local cli = find_up(script_dir, 'CLI.py', 8)
if cli and cli ~= '' then
repo_root = cli:match('(.*)[/\\]') or ''
end
end
end
if repo_root == '' then
return -- Can't find repo root, skip logging to database
end
-- Escape paths for Python subprocess
repo_root = repo_root:gsub('\\', '/')
-- Use Python to write to the database since Lua can't easily access sqlite3
-- We use a subprocess call with minimal Python to insert into logs.db
local python = (opts and opts.python_path) and tostring(opts.python_path) or 'python'
local db_path = repo_root .. '/logs.db'
local script = string.format(
"import sqlite3,os;p='%s';c=sqlite3.connect(p) if os.path.exists(p) else None;c and (c.execute('INSERT INTO logs (level,module,message) VALUES (?,?,?)',('%s','mpv','%s')),c.commit(),c.close())",
db_path:gsub('\\', '/'),
level,
message
)
pcall(function()
mp.command_native_async({ name = 'subprocess', args = { python, '-c', script }, cwd = nil }, function() end)
end)
end
-- Combined log: to file + database (for persistence and debugging)
local function _log_all(level, text)
if not text or text == '' then
return
end
level = tostring(level or 'INFO'):upper()
text = tostring(text)
-- Log to file
_lua_log('[' .. level .. '] ' .. text)
-- Log to database (async, non-blocking)
_log_to_db(level, text)
end
local function ensure_uosc_loaded()
if _uosc_loaded or _is_script_loaded('uosc') then
_uosc_loaded = true
@@ -2317,8 +2392,9 @@ function M.run_pipeline(pipeline_cmd, seeds, cb)
end
ensure_mpv_ipc_server()
-- Use longer timeout for .mpv -url commands since they may involve downloading
local timeout_seconds = pipeline_cmd:match('%.mpv%s+%-url') and 120 or 30
-- Use shorter timeout for .mpv -url commands since they just queue the URL (non-blocking)
-- The actual URL resolution happens asynchronously in MPV itself
local timeout_seconds = pipeline_cmd:match('%.mpv%s+%-url') and 10 or 30
_run_pipeline_request_async(pipeline_cmd, seeds, timeout_seconds, function(resp, err)
_lua_log('M.run_pipeline callback fired: resp=' .. tostring(resp) .. ', err=' .. tostring(err))
if resp and resp.success then
@@ -2776,6 +2852,7 @@ mp.register_script_message('medios-load-url-event', function(json)
_lua_log('[LOAD-URL] Trimmed URL: "' .. url .. '"')
if url == '' then
_lua_log('[LOAD-URL] URL is empty')
_log_all('ERROR', 'Load URL failed: URL is empty')
mp.osd_message('URL is empty', 2)
if ensure_uosc_loaded() then
_lua_log('[LOAD-URL] Closing menu due to empty URL')
@@ -2785,6 +2862,7 @@ mp.register_script_message('medios-load-url-event', function(json)
end
mp.osd_message('Loading URL...', 1)
_log_all('INFO', 'Load URL started: ' .. url)
_lua_log('[LOAD-URL] Starting to load: ' .. url)
local function close_menu()
@@ -2806,11 +2884,13 @@ mp.register_script_message('medios-load-url-event', function(json)
local ok_load = pcall(mp.commandv, 'loadfile', url, 'replace')
if ok_load then
_lua_log('[LOAD-URL] Direct loadfile command sent successfully')
_log_all('INFO', 'Load URL succeeded via direct load')
mp.osd_message('URL loaded', 2)
close_menu()
return
else
_lua_log('[LOAD-URL] Direct loadfile command failed')
_log_all('ERROR', 'Load URL failed: direct loadfile command failed')
mp.osd_message('Load URL failed (direct)', 3)
close_menu()
return
@@ -2824,24 +2904,57 @@ mp.register_script_message('medios-load-url-event', function(json)
_lua_log('[LOAD-URL] Pipeline helper ready: ' .. tostring(helper_ready))
if not helper_ready then
_lua_log('[LOAD-URL] Pipeline helper not available')
mp.osd_message('Pipeline helper not running (try menu again)', 3)
_lua_log('[LOAD-URL] Pipeline helper not available, attempting to start...')
_log_all('WARN', 'Pipeline helper not running, attempting auto-start')
mp.osd_message('Starting pipeline helper...', 2)
-- Attempt to start the helper asynchronously
attempt_start_pipeline_helper_async(function(success)
if success then
_lua_log('[LOAD-URL] Helper started successfully, retry Load URL from menu')
_log_all('INFO', 'Pipeline helper started successfully')
mp.osd_message('Helper started! Try Load URL again', 2)
else
_lua_log('[LOAD-URL] Failed to start helper')
_log_all('ERROR', 'Failed to start pipeline helper')
mp.osd_message('Could not start pipeline helper', 3)
end
close_menu()
end)
return
end
-- Use pipeline to download/prepare the URL
local pipeline_cmd = '.mpv -url ' .. quote_pipeline_arg(url) .. ' -play'
_lua_log('[LOAD-URL] Sending to pipeline: ' .. pipeline_cmd)
_lua_log('[LOAD-URL] Pipeline helper ready: ' .. tostring(_is_pipeline_helper_ready()))
-- Add a timeout message after a delay to give user feedback
local timeout_timer = nil
timeout_timer = mp.add_timeout(5, function()
if timeout_timer then
mp.osd_message('Still loading... (helper may be resolving URL)', 2)
_log_all('WARN', 'Load URL still processing after 5 seconds')
_lua_log('[LOAD-URL] Timeout message shown (helper still processing)')
end
end)
M.run_pipeline(pipeline_cmd, nil, function(resp, err)
if timeout_timer then
timeout_timer:kill()
timeout_timer = nil
end
_lua_log('[LOAD-URL] Pipeline callback received: resp=' .. tostring(resp) .. ', err=' .. tostring(err))
if err then
_lua_log('[LOAD-URL] Pipeline error: ' .. tostring(err))
_log_all('ERROR', 'Load URL pipeline failed: ' .. tostring(err))
mp.osd_message('Load URL failed: ' .. tostring(err), 3)
close_menu()
return
end
_lua_log('[LOAD-URL] URL loaded successfully')
_log_all('INFO', 'Load URL succeeded')
mp.osd_message('URL loaded', 2)
close_menu()
end)

23
cmdnat/pipe.py
View File

@@ -1981,6 +1981,29 @@ def _run(result: Any, args: Sequence[str], config: Dict[str, Any]) -> int:
"If you need full [main2] logs, restart mpv so it starts with --log-file."
)
# Print database logs for mpv module (helper output)
try:
import sqlite3
log_db_path = str((Path(__file__).resolve().parent.parent / "logs.db"))
conn = sqlite3.connect(log_db_path, timeout=5.0)
cur = conn.cursor()
cur.execute(
"SELECT level, module, message FROM logs WHERE module = 'mpv' ORDER BY timestamp DESC LIMIT 200"
)
mpv_logs = cur.fetchall()
cur.close()
conn.close()
print("Helper logs from database (mpv module, most recent first):")
if mpv_logs:
for level, module, message in mpv_logs:
print(f"[{level}] {message}")
else:
print("(no helper logs found)")
except Exception as e:
debug(f"Could not fetch database logs: {e}")
pass
# Also print the helper log tail (this captures Python helper output that won't
# necessarily show up in MPV's own log-file).
try:

BIN
logs.db-shm Normal file
View File

Binary file not shown.

BIN
logs.db-wal Normal file
View File

Binary file not shown.

500
mpv_logs_with_db.txt Normal file
View File

@@ -0,0 +1,500 @@
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