Dec 27 22:15:01 volumio volumio[1264]: info: [ytmusic] Obtained session PO token using visitorData (expires in 43199 seconds) Dec 27 22:15:05 volumio volumio[1264]: info: [ytmusic] Going to refresh session PO token in 43099 seconds Dec 27 22:15:05 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 27 22:15:05 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 27 22:15:17 volumio go-librespot[6780]: time="2025-12-27T22:15:17+02:00" level=trace msg="sent dealer ping" Dec 27 22:15:17 volumio go-librespot[6780]: time="2025-12-27T22:15:17+02:00" level=trace msg="received dealer pong" Dec 27 22:15:18 volumio volumio[1264]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 27 22:15:23 volumio volumio[1264]: info: CALLMETHOD: music_service youtube2 configSaveDisclaimer [object Object] Dec 27 22:15:23 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: youtube2 , configSaveDisclaimer Dec 27 22:15:23 volumio volumio[1264]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 27 22:15:28 volumio volumio[1264]: info: [youtube2] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Dec 27 22:15:28 volumio volumio[1264]: info: [youtube2] Innertube support service: Start service with Node Dec 27 22:15:28 volumio volumio[1264]: info: CoreCommandRouter::volumioGetState Dec 27 22:15:28 volumio volumio[1264]: info: CorePlayQueue::getTrack 3 Dec 27 22:15:30 volumio volumio[1264]: info: [youtube2] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":37043}} Dec 27 22:15:30 volumio volumio[1264]: info: [youtube2] Innertube support service running at http://127.0.0.1:37043 Dec 27 22:15:36 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 27 22:15:36 volumio volumio[1264]: info: [youtube2-browse] browseUri: youtube2 Dec 27 22:15:38 volumio volumio[1264]: info: [youtube2] Obtained session PO token using visitorData (expires in 43199 seconds) Dec 27 22:15:42 volumio volumio[1264]: info: [youtube2] Going to refresh session PO token in 43099 seconds Dec 27 22:15:42 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:42 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:47 volumio go-librespot[6780]: time="2025-12-27T22:15:47+02:00" level=trace msg="sent dealer ping" Dec 27 22:15:47 volumio go-librespot[6780]: time="2025-12-27T22:15:47+02:00" level=trace msg="received dealer pong" Dec 27 22:15:47 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 27 22:15:47 volumio volumio[1264]: info: [youtube2-browse] browseUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:48 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:53 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:53 volumio volumio[1264]: info: CoreCommandRouter::volumioAddQueueItems Dec 27 22:15:53 volumio volumio[1264]: info: CoreStateMachine::addQueueItems Dec 27 22:15:53 volumio volumio[1264]: info: CorePlayQueue::addQueueItems Dec 27 22:15:53 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:15:53 volumio volumio[1264]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D Dec 27 22:15:53 volumio volumio[1264]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D in service youtube2 Dec 27 22:15:53 volumio volumio[1264]: info: [youtube2-browse] explodeUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D Dec 27 22:15:54 volumio volumio[1264]: info: CoreCommandRouter::volumioPushQueue Dec 27 22:15:54 volumio volumio[1264]: info: CorePlayQueue::saveQueue Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::updateTrackBlock Dec 27 22:15:54 volumio volumio[1264]: info: CorePlayQueue::getTrackBlock Dec 27 22:15:54 volumio volumio[1264]: info: CoreCommandRouter::volumioPlay Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::play index 70 Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::stop Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::play index undefined Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:15:54 volumio volumio[1264]: info: CorePlayQueue::getTrack 70 Dec 27 22:15:54 volumio volumio[1264]: info: CoreStateMachine::startPlaybackTimer Dec 27 22:15:54 volumio volumio[1264]: info: CorePlayQueue::getTrack 70 Dec 27 22:15:54 volumio volumio[1264]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22kPa7bsKwL-c%22%2C%22playlistId%22%3A%22RDCLAK5uy_ngV593f_RWoumLPyvjLhVrSkxBlLpKKAE%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Lady%20Gaga%2C%20Bruno%20Mars%20-%20Die%20With%20A%20Smile%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22Lady%20Gaga%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FkPa7bsKwL-c%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLAQiJs48T0874m4PwpyLlb_MVZ0zg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22kPa7bsKwL-c%22%2C%22playlistId%22%3A%22RDCLAK5uy_ngV593f_RWoumLPyvjLhVrSkxBlLpKKAE%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Dec 27 22:15:54 volumio volumio[1264]: info: [ytmusic] Obtained PO token for video #kPa7bsKwL-c: MlWu0MDVoRO5_a7unbc6r4pJwTQautAIsAkIUtBH4xrKGhCor-qcTzoH2BjPzude08IFkGAXWdW4R-JrjOmFtVqaLDBNDFZXOKNIeSpiDe7bC9hf2222 Dec 27 22:15:55 volumio volumio[1264]: info: [ytmusic] Obtained PO token for video #kPa7bsKwL-c: MlW7uelRfswLa7uHtDPlcDjf1F0zPg_XAp8dO_nDPMV4jAXBhm5DkIiRzXHmSjiBYVQQ-UmThgoK0fcCpW1aaugMOVlkiImIijWmKkLRwDDF9-sLNRPY Dec 27 22:15:55 volumio volumio[1264]: info: [youtube2] VideoModel.getInfo(kPa7bsKwL-c): validating stream URL "https://rr2---sn-vhxb5uxax03g-px8s.googlevideo.com/videoplayback?expire=1766888155&ei=ez5QafqRBaKI6dsPvPjqwQU&ip=79.98.240.100&id=o-AF6FH6A1hAnfY47XzOZRFSY7Rju8qR_7uTK6NYaRjJXv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=774&met=1766866555%2C&mh=Ji&mm=31%2C29&mn=sn-vhxb5uxax03g-px8s%2Csn-3c27sn7z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=1575000&bui=AYUSA3AQtNoyBb2wf6qqBKmdN7uzM5xwn9ep7fnCebS0hJKucch99snTcyLvmp7sCgQl8kYPBGXPHb_c&spc=wH4Qq9Sbrin4XvbMqiR-w1b_r6mkrJTvyQFNpF5hR5xIRXlKoft0fA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A5kTEwFYLprp1hg5JcjaEqsR&rqh=1&gir=yes&clen=4113988&dur=252.321&lmt=1731709075916431&mt=1766866191&fvip=15&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=3n-g4uyhkmELIQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAM23CA1w8RR3qdScLRdc-8H9IBkLXKIHMHFNOAI7NPmwAiAjTdvwgr95gVvPP-SIM3RZ9cCRlqyLl91Wgme62_7-RA%3D%3D&sig=AJfQdSswRQIhAOaEs6MxZ9KAdX2PLcx-IQjTTc-a7_S_TM6bLDoC44jPAiA802G88bHd0-kPJqHRDqoDlgtQ2rN-42NPlNy5VjOijA%3D%3D&pot=MlW7uelRfswLa7uHtDPlcDjf1F0zPg_XAp8dO_nDPMV4jAXBhm5DkIiRzXHmSjiBYVQQ-UmThgoK0fcCpW1aaugMOVlkiImIijWmKkLRwDDF9-sLNRPY&cver=1.20250219.01.00"... Dec 27 22:15:55 volumio volumio[1264]: info: [youtube2] VideoModel.getInfo(kPa7bsKwL-c): stream validated in 0.079s. Dec 27 22:15:55 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 27 22:15:55 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Enabled Dec 27 22:15:55 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 22:15:55 volumio volumio[1264]: info: sendMpdCommand stop took 1 milliseconds Dec 27 22:15:55 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand clear Dec 27 22:15:55 volumio volumio[1264]: info: Dec 27 22:15:55 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:15:55 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:15:55 volumio volumio[1264]: info: sendMpdCommand clear took 1 milliseconds Dec 27 22:15:55 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-vhxb5uxax03g-px8s.googlevideo.com/videoplayback?expire=1766888155&ei=ez5QafqRBaKI6dsPvPjqwQU&ip=79.98.240.100&id=o-AF6FH6A1hAnfY47XzOZRFSY7Rju8qR_7uTK6NYaRjJXv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=774&met=1766866555%2C&mh=Ji&mm=31%2C29&mn=sn-vhxb5uxax03g-px8s%2Csn-3c27sn7z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=1575000&bui=AYUSA3AQtNoyBb2wf6qqBKmdN7uzM5xwn9ep7fnCebS0hJKucch99snTcyLvmp7sCgQl8kYPBGXPHb_c&spc=wH4Qq9Sbrin4XvbMqiR-w1b_r6mkrJTvyQFNpF5hR5xIRXlKoft0fA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A5kTEwFYLprp1hg5JcjaEqsR&rqh=1&gir=yes&clen=4113988&dur=252.321&lmt=1731709075916431&mt=1766866191&fvip=15&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=3n-g4uyhkmELIQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAM23CA1w8RR3qdScLRdc-8H9IBkLXKIHMHFNOAI7NPmwAiAjTdvwgr95gVvPP-SIM3RZ9cCRlqyLl91Wgme62_7-RA%3D%3D&sig=AJfQdSswRQIhAOaEs6MxZ9KAdX2PLcx-IQjTTc-a7_S_TM6bLDoC44jPAiA802G88bHd0-kPJqHRDqoDlgtQ2rN-42NPlNy5VjOijA%3D%3D&pot=MlW7uelRfswLa7uHtDPlcDjf1F0zPg_XAp8dO_nDPMV4jAXBhm5DkIiRzXHmSjiBYVQQ-UmThgoK0fcCpW1aaugMOVlkiImIijWmKkLRwDDF9-sLNRPY&cver=1.20250219.01.00&t.YouTube" Dec 27 22:15:55 volumio volumio[1264]: error: updateQueue error: null Dec 27 22:15:55 volumio volumio[1264]: info: ------------------------------ 2ms Dec 27 22:15:55 volumio volumio[1264]: info: Dec 27 22:15:55 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:15:55 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:15:55 volumio volumio[1264]: info: sendMpdCommand addid "https://rr2---sn-vhxb5uxax03g-px8s.googlevideo.com/videoplayback?expire=1766888155&ei=ez5QafqRBaKI6dsPvPjqwQU&ip=79.98.240.100&id=o-AF6FH6A1hAnfY47XzOZRFSY7Rju8qR_7uTK6NYaRjJXv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=774&met=1766866555%2C&mh=Ji&mm=31%2C29&mn=sn-vhxb5uxax03g-px8s%2Csn-3c27sn7z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=1575000&bui=AYUSA3AQtNoyBb2wf6qqBKmdN7uzM5xwn9ep7fnCebS0hJKucch99snTcyLvmp7sCgQl8kYPBGXPHb_c&spc=wH4Qq9Sbrin4XvbMqiR-w1b_r6mkrJTvyQFNpF5hR5xIRXlKoft0fA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A5kTEwFYLprp1hg5JcjaEqsR&rqh=1&gir=yes&clen=4113988&dur=252.321&lmt=1731709075916431&mt=1766866191&fvip=15&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=3n-g4uyhkmELIQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAM23CA1w8RR3qdScLRdc-8H9IBkLXKIHMHFNOAI7NPmwAiAjTdvwgr95gVvPP-SIM3RZ9cCRlqyLl91Wgme62_7-RA%3D%3D&sig=AJfQdSswRQIhAOaEs6MxZ9KAdX2PLcx-IQjTTc-a7_S_TM6bLDoC44jPAiA802G88bHd0-kPJqHRDqoDlgtQ2rN-42NPlNy5VjOijA%3D%3D&pot=MlW7uelRfswLa7uHtDPlcDjf1F0zPg_XAp8dO_nDPMV4jAXBhm5DkIiRzXHmSjiBYVQQ-UmThgoK0fcCpW1aaugMOVlkiImIijWmKkLRwDDF9-sLNRPY&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds Dec 27 22:15:55 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:15:55 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:15:55 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:15:55 volumio volumio[1264]: info: Dec 27 22:15:55 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:15:55 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:15:55 volumio volumio[1264]: info: ------------------------------ 4ms Dec 27 22:15:55 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 22:15:55 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand play Dec 27 22:15:55 volumio volumio[1264]: info: ------------------------------ 3ms Dec 27 22:15:55 volumio volumio[1264]: info: sendMpdCommand play took 2 milliseconds Dec 27 22:15:56 volumio volumio[1264]: info: Dec 27 22:15:56 volumio volumio[1264]: ---------------------------- MPD announces state update: player Dec 27 22:15:56 volumio volumio[1264]: info: ControllerMpd::getState Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand status Dec 27 22:15:56 volumio volumio[1264]: info: Dec 27 22:15:56 volumio volumio[1264]: ---------------------------- MPD announces state update: player Dec 27 22:15:56 volumio volumio[1264]: info: sendMpdCommand status took 2 milliseconds Dec 27 22:15:56 volumio volumio[1264]: info: ControllerMpd::getState Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand status Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::parseState Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 22:15:56 volumio volumio[1264]: info: sendMpdCommand status took 2 milliseconds Dec 27 22:15:56 volumio volumio[1264]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::parseState Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::parseTrackInfo Dec 27 22:15:56 volumio volumio[1264]: info: ControllerMpd::pushState Dec 27 22:15:56 volumio volumio[1264]: info: CoreCommandRouter::servicePushState Dec 27 22:15:56 volumio volumio[1264]: info: CorePlayQueue::getTrack 70 Dec 27 22:15:56 volumio volumio[1264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lady Gaga, Bruno Mars - Die With A Smile (Official Music Video)","artist":"LadyGagaVEVO","album":"YouTube","uri":"https://rr2---sn-vhxb5uxax03g-px8s.googlevideo.com/videoplayback?expire=1766888155&ei=ez5QafqRBaKI6dsPvPjqwQU&ip=79.98.240.100&id=o-AF6FH6A1hAnfY47XzOZRFSY7Rju8qR_7uTK6NYaRjJXv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=774&met=1766866555%2C&mh=Ji&mm=31%2C29&mn=sn-vhxb5uxax03g-px8s%2Csn-3c27sn7z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=1575000&bui=AYUSA3AQtNoyBb2wf6qqBKmdN7uzM5xwn9ep7fnCebS0hJKucch99snTcyLvmp7sCgQl8kYPBGXPHb_c&spc=wH4Qq9Sbrin4XvbMqiR-w1b_r6mkrJTvyQFNpF5hR5xIRXlKoft0fA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A5kTEwFYLprp1hg5JcjaEqsR&rqh=1&gir=yes&clen=4113988&dur=252.321&lmt=1731709075916431&mt=1766866191&fvip=15&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=3n-g4uyhkmELIQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAM23CA1w8RR3qdScLRdc-8H9IBkLXKIHMHFNOAI7NPmwAiAjTdvwgr95gVvPP-SIM3RZ9cCRlqyLl91Wgme62_7-RA%3D%3D&sig=AJfQdSswRQIhAOaEs6MxZ9KAdX2PLcx-IQjTTc-a7_S_TM6bLDoC44jPAiA802G88bHd0-kPJqHRDqoDlgtQ2rN-42NPlNy5VjOijA%3D%3D&pot=MlW7uelRfswLa7uHtDPlcDjf1F0zPg_XAp8dO_nDPMV4jAXBhm5DkIiRzXHmSjiBYVQQ-UmThgoK0fcCpW1aaugMOVlkiImIijWmKkLRwDDF9-sLNRPY&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 27 22:15:56 volumio volumio[1264]: verbose: CURRENT POSITION 70 Dec 27 22:15:56 volumio volumio[1264]: info: CoreStateMachine::syncState stateService play Dec 27 22:15:56 volumio volumio[1264]: info: CoreStateMachine::syncState currentStatus stop Dec 27 22:15:56 volumio volumio[1264]: info: ------------------------------ 13ms Dec 27 22:15:56 volumio volumio[1264]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 27 22:15:56 volumio volumio[1264]: verbose: ControllerMpd::parseTrackInfo Dec 27 22:15:56 volumio volumio[1264]: info: ControllerMpd::pushState Dec 27 22:15:56 volumio volumio[1264]: info: CoreCommandRouter::servicePushState Dec 27 22:15:56 volumio volumio[1264]: info: CorePlayQueue::getTrack 70 Dec 27 22:15:56 volumio volumio[1264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lady Gaga, Bruno Mars - Die With A Smile (Official Music Video)","artist":"LadyGagaVEVO","album":"YouTube","uri":"https://rr2---sn-vhxb5uxax03g-px8s.googlevideo.com/videoplayback?expire=1766888155&ei=ez5QafqRBaKI6dsPvPjqwQU&ip=79.98.240.100&id=o-AF6FH6A1hAnfY47XzOZRFSY7Rju8qR_7uTK6NYaRjJXv&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=774&met=1766866555%2C&mh=Ji&mm=31%2C29&mn=sn-vhxb5uxax03g-px8s%2Csn-3c27sn7z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&gcr=ua&initcwndbps=1575000&bui=AYUSA3AQtNoyBb2wf6qqBKmdN7uzM5xwn9ep7fnCebS0hJKucch99snTcyLvmp7sCgQl8kYPBGXPHb_c&spc=wH4Qq9Sbrin4XvbMqiR-w1b_r6mkrJTvyQFNpF5hR5xIRXlKoft0fA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=A5kTEwFYLprp1hg5JcjaEqsR&rqh=1&gir=yes&clen=4113988&dur=252.321&lmt=1731709075916431&mt=1766866191&fvip=15&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=3n-g4uyhkmELIQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAM23CA1w8RR3qdScLRdc-8H9IBkLXKIHMHFNOAI7NPmwAiAjTdvwgr95gVvPP-SIM3RZ9cCRlqyLl91Wgme62_7-RA%3D%3D&sig=AJfQdSswRQIhAOaEs6MxZ9KAdX2PLcx-IQjTTc-a7_S_TM6bLDoC44jPAiA802G88bHd0-kPJqHRDqoDlgtQ2rN-42NPlNy5VjOijA%3D%3D&pot=MlW7uelRfswLa7uHtDPlcDjf1F0zPg_XAp8dO_nDPMV4jAXBhm5DkIiRzXHmSjiBYVQQ-UmThgoK0fcCpW1aaugMOVlkiImIijWmKkLRwDDF9-sLNRPY&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 27 22:15:56 volumio volumio[1264]: verbose: CURRENT POSITION 70 Dec 27 22:15:56 volumio volumio[1264]: info: CoreStateMachine::syncState stateService play Dec 27 22:15:56 volumio volumio[1264]: info: CoreStateMachine::syncState currentStatus play Dec 27 22:15:56 volumio volumio[1264]: info: Received an update from plugin. extracting info from payload Dec 27 22:15:56 volumio volumio[1264]: info: CoreStateMachine::pushState Dec 27 22:15:56 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 22:15:56 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 27 22:15:56 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Added mpdStateListener Dec 27 22:15:56 volumio volumio[1264]: info: CoreStateMachine::pushState Dec 27 22:15:56 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 27 22:15:56 volumio volumio[1264]: info: ------------------------------ 26ms Dec 27 22:15:56 volumio volumio[1264]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 27 22:16:10 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:10 volumio volumio[1264]: info: CoreCommandRouter::volumioAddQueueItems Dec 27 22:16:10 volumio volumio[1264]: info: CoreStateMachine::addQueueItems Dec 27 22:16:10 volumio volumio[1264]: info: CorePlayQueue::addQueueItems Dec 27 22:16:10 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:10 volumio volumio[1264]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mnpGKdin-1z_7pVXflRIhFoz5xYOMAmig%22%7D%7D%7D Dec 27 22:16:10 volumio volumio[1264]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mnpGKdin-1z_7pVXflRIhFoz5xYOMAmig%22%7D%7D%7D in service youtube2 Dec 27 22:16:10 volumio volumio[1264]: info: [youtube2-browse] explodeUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mnpGKdin-1z_7pVXflRIhFoz5xYOMAmig%22%7D%7D%7D Dec 27 22:16:11 volumio volumio[1264]: [YOUTUBEJS][Text]: Unable to find matching run for attachment run. Skipping... { Dec 27 22:16:11 volumio volumio[1264]: attachment_run: { Dec 27 22:16:11 volumio volumio[1264]: startIndex: 18, Dec 27 22:16:11 volumio volumio[1264]: element: { type: [Object], properties: [Object] }, Dec 27 22:16:11 volumio volumio[1264]: alignment: 'ALIGNMENT_VERTICAL_CENTER' Dec 27 22:16:11 volumio volumio[1264]: }, Dec 27 22:16:11 volumio volumio[1264]: input_data: { Dec 27 22:16:11 volumio volumio[1264]: content: 'SUMERIAN and Poppy', Dec 27 22:16:11 volumio volumio[1264]: styleRuns: [ [Object], [Object] ], Dec 27 22:16:11 volumio volumio[1264]: attachmentRuns: [ [Object] ] Dec 27 22:16:11 volumio volumio[1264]: }, Dec 27 22:16:11 volumio volumio[1264]: parsed_runs: [ { text: 'SUMERIAN and Poppy', startIndex: 0 } ] Dec 27 22:16:11 volumio volumio[1264]: } Dec 27 22:16:11 volumio volumio[1264]: [YOUTUBEJS][Text]: Unable to find matching run for attachment run. Skipping... { Dec 27 22:16:11 volumio volumio[1264]: attachment_run: { Dec 27 22:16:11 volumio volumio[1264]: startIndex: 11, Dec 27 22:16:11 volumio volumio[1264]: element: { type: [Object], properties: [Object] }, Dec 27 22:16:11 volumio volumio[1264]: alignment: 'ALIGNMENT_VERTICAL_CENTER' Dec 27 22:16:11 volumio volumio[1264]: }, Dec 27 22:16:11 volumio volumio[1264]: input_data: { Dec 27 22:16:11 volumio volumio[1264]: content: 'riserecords and Pale Chord Music', Dec 27 22:16:11 volumio volumio[1264]: styleRuns: [ [Object], [Object] ], Dec 27 22:16:11 volumio volumio[1264]: attachmentRuns: [ [Object] ] Dec 27 22:16:11 volumio volumio[1264]: }, Dec 27 22:16:11 volumio volumio[1264]: parsed_runs: [ { text: 'riserecords and Pale Chord Music', startIndex: 0 } ] Dec 27 22:16:11 volumio volumio[1264]: } Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::volumioPushQueue Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::saveQueue Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::updateTrackBlock Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrackBlock Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::volumioPlay Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::play index 94 Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::stop Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::stPlaybackTimer Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::updateTrackBlock Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrackBlock Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::pushState Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrack 70 Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::serviceStop Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrack 70 Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::serviceStop Dec 27 22:16:11 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Dec 27 22:16:11 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 27 22:16:11 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Disabled Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 22:16:11 volumio volumio[1264]: info: ControllerMpd::stop Dec 27 22:16:11 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 22:16:11 volumio volumio[1264]: info: Dec 27 22:16:11 volumio volumio[1264]: ---------------------------- MPD announces state update: player Dec 27 22:16:11 volumio volumio[1264]: info: sendMpdCommand stop took 27 milliseconds Dec 27 22:16:11 volumio volumio[1264]: info: ControllerMpd::getState Dec 27 22:16:11 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand status Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::play index undefined Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::startPlaybackTimer Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:11 volumio volumio[1264]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223rS83uI0Wak%22%2C%22playlistId%22%3A%22RDCLAK5uy_mnpGKdin-1z_7pVXflRIhFoz5xYOMAmig%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22POPPY%2C%20AMY%20LEE%2C%20COURTNEY%20LAPLANTE%20-%20End%20of%20You%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22SUMERIAN%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F3rS83uI0Wak%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBSEJfqlBgh8M7nuDiBphsbJv9VTQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223rS83uI0Wak%22%2C%22playlistId%22%3A%22RDCLAK5uy_mnpGKdin-1z_7pVXflRIhFoz5xYOMAmig%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Dec 27 22:16:11 volumio volumio[1264]: info: sendMpdCommand status took 9 milliseconds Dec 27 22:16:11 volumio volumio[1264]: verbose: ControllerMpd::parseState Dec 27 22:16:11 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 22:16:11 volumio volumio[1264]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 27 22:16:11 volumio volumio[1264]: verbose: ControllerMpd::parseTrackInfo Dec 27 22:16:11 volumio volumio[1264]: info: ControllerMpd::pushState Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::servicePushState Dec 27 22:16:11 volumio volumio[1264]: info: CoreStateMachine::pushState Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 22:16:11 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 27 22:16:11 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:11 volumio volumio[1264]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 27 22:16:11 volumio volumio[1264]: info: ------------------------------ 50ms Dec 27 22:16:11 volumio volumio[1264]: info: [ytmusic] Obtained PO token for video #3rS83uI0Wak: MlU2FHHTR7W2rTYqLLHcCYUZWfCrvDauv1mQlmFBBbzFSohsHux66TVXQNx-yAH43JKdVNERv3O3F3qvPe9jE1XKtPT8CrDxN_M2SOaJXrTdGfrnf3w_ Dec 27 22:16:11 volumio volumio[1264]: info: touch_display: Setting screensaver timeout to 3600 seconds. Dec 27 22:16:11 volumio volumio[1264]: info: [ytmusic] Obtained PO token for video #3rS83uI0Wak: MlWi35Cft42kh6Lhzf0sMZczzTtK8MaWrXMEXYAN9YTXYByn_6CK0Sd91BefhPHAzrgJnzBdT0ulPe5k3KOTK0fgID8dRkDJJdlFp1TY5gWgRRIAtQEo Dec 27 22:16:11 volumio volumio[1264]: info: [youtube2] VideoModel.getInfo(3rS83uI0Wak): validating stream URL "https://rr4---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888171&ei=iz5QabbMKpnLi9oPpJOtkAY&ip=79.98.240.100&id=o-AKXKMuChFXeTyMTxRwFY3qj15ToO1n07wtdGKeL9moL9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=290&met=1766866571%2C&mh=Rn&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27snel&ms=au%2Crdu&mv=m&mvi=4&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3DRM0kJd9Ewzed6IisO8k2g-19K0Nx0baNPf_JpIqxQfyOTOuspFwGES9zSvtFoTrlVk86NLcz0&spc=wH4Qq0d_KdZBfvuGq3MQUY2qjGwZfl5DrosOo23Dh4xmoq7qKm-OVQ&vprv=1&svpuc=1&xtags=acont%3Doriginal%3Alang%3Den-US&mime=audio%2Fwebm&ns=Jzc_zIurPAcXZcPqUiiZcU0R&rqh=1&gir=yes&clen=3326309&dur=205.081&lmt=1756911242500159&mt=1766866191&fvip=9&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=3308224&n=TYU4g3NSG12kdA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAN2OMFW1HRbOkjb1xLgRw5pr79iGKX2OSWS5PlSk-L01AiAg-D3i0UYQqYQ3XJbLTIxhAiYhK9kpvR_eNz3Oo00NCw%3D%3D&sig=AJfQdSswRQIgfFs8WyHYstVtCvKmH4U7k4uqQu85omkr46X142VHxVsCIQCNOWyf0Hjc_cp8Cqm5m4PYSEOQUdhslO-1NtRCrCbZ8g%3D%3D&pot=MlWi35Cft42kh6Lhzf0sMZczzTtK8MaWrXMEXYAN9YTXYByn_6CK0Sd91BefhPHAzrgJnzBdT0ulPe5k3KOTK0fgID8dRkDJJdlFp1TY5gWgRRIAtQEo&cver=1.20250219.01.00"... Dec 27 22:16:12 volumio volumio[1264]: info: [youtube2] VideoModel.getInfo(3rS83uI0Wak): stream validated in 0.074s. Dec 27 22:16:12 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 27 22:16:12 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Enabled Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 22:16:12 volumio volumio[1264]: info: sendMpdCommand stop took 1 milliseconds Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand clear Dec 27 22:16:12 volumio volumio[1264]: info: Dec 27 22:16:12 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:16:12 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:16:12 volumio volumio[1264]: info: sendMpdCommand clear took 2 milliseconds Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888171&ei=iz5QabbMKpnLi9oPpJOtkAY&ip=79.98.240.100&id=o-AKXKMuChFXeTyMTxRwFY3qj15ToO1n07wtdGKeL9moL9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=290&met=1766866571%2C&mh=Rn&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27snel&ms=au%2Crdu&mv=m&mvi=4&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3DRM0kJd9Ewzed6IisO8k2g-19K0Nx0baNPf_JpIqxQfyOTOuspFwGES9zSvtFoTrlVk86NLcz0&spc=wH4Qq0d_KdZBfvuGq3MQUY2qjGwZfl5DrosOo23Dh4xmoq7qKm-OVQ&vprv=1&svpuc=1&xtags=acont%3Doriginal%3Alang%3Den-US&mime=audio%2Fwebm&ns=Jzc_zIurPAcXZcPqUiiZcU0R&rqh=1&gir=yes&clen=3326309&dur=205.081&lmt=1756911242500159&mt=1766866191&fvip=9&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=3308224&n=TYU4g3NSG12kdA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAN2OMFW1HRbOkjb1xLgRw5pr79iGKX2OSWS5PlSk-L01AiAg-D3i0UYQqYQ3XJbLTIxhAiYhK9kpvR_eNz3Oo00NCw%3D%3D&sig=AJfQdSswRQIgfFs8WyHYstVtCvKmH4U7k4uqQu85omkr46X142VHxVsCIQCNOWyf0Hjc_cp8Cqm5m4PYSEOQUdhslO-1NtRCrCbZ8g%3D%3D&pot=MlWi35Cft42kh6Lhzf0sMZczzTtK8MaWrXMEXYAN9YTXYByn_6CK0Sd91BefhPHAzrgJnzBdT0ulPe5k3KOTK0fgID8dRkDJJdlFp1TY5gWgRRIAtQEo&cver=1.20250219.01.00&t.YouTube" Dec 27 22:16:12 volumio volumio[1264]: error: updateQueue error: null Dec 27 22:16:12 volumio volumio[1264]: info: ------------------------------ 2ms Dec 27 22:16:12 volumio volumio[1264]: info: Dec 27 22:16:12 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:16:12 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:16:12 volumio volumio[1264]: info: sendMpdCommand addid "https://rr4---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888171&ei=iz5QabbMKpnLi9oPpJOtkAY&ip=79.98.240.100&id=o-AKXKMuChFXeTyMTxRwFY3qj15ToO1n07wtdGKeL9moL9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=290&met=1766866571%2C&mh=Rn&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27snel&ms=au%2Crdu&mv=m&mvi=4&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3DRM0kJd9Ewzed6IisO8k2g-19K0Nx0baNPf_JpIqxQfyOTOuspFwGES9zSvtFoTrlVk86NLcz0&spc=wH4Qq0d_KdZBfvuGq3MQUY2qjGwZfl5DrosOo23Dh4xmoq7qKm-OVQ&vprv=1&svpuc=1&xtags=acont%3Doriginal%3Alang%3Den-US&mime=audio%2Fwebm&ns=Jzc_zIurPAcXZcPqUiiZcU0R&rqh=1&gir=yes&clen=3326309&dur=205.081&lmt=1756911242500159&mt=1766866191&fvip=9&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=3308224&n=TYU4g3NSG12kdA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAN2OMFW1HRbOkjb1xLgRw5pr79iGKX2OSWS5PlSk-L01AiAg-D3i0UYQqYQ3XJbLTIxhAiYhK9kpvR_eNz3Oo00NCw%3D%3D&sig=AJfQdSswRQIgfFs8WyHYstVtCvKmH4U7k4uqQu85omkr46X142VHxVsCIQCNOWyf0Hjc_cp8Cqm5m4PYSEOQUdhslO-1NtRCrCbZ8g%3D%3D&pot=MlWi35Cft42kh6Lhzf0sMZczzTtK8MaWrXMEXYAN9YTXYByn_6CK0Sd91BefhPHAzrgJnzBdT0ulPe5k3KOTK0fgID8dRkDJJdlFp1TY5gWgRRIAtQEo&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds Dec 27 22:16:12 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:16:12 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:16:12 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:16:12 volumio volumio[1264]: info: Dec 27 22:16:12 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:16:12 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:16:12 volumio volumio[1264]: info: ------------------------------ 4ms Dec 27 22:16:12 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand play Dec 27 22:16:12 volumio volumio[1264]: info: ------------------------------ 3ms Dec 27 22:16:12 volumio volumio[1264]: info: sendMpdCommand play took 3 milliseconds Dec 27 22:16:12 volumio volumio[1264]: info: Dec 27 22:16:12 volumio volumio[1264]: ---------------------------- MPD announces state update: player Dec 27 22:16:12 volumio volumio[1264]: info: ControllerMpd::getState Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand status Dec 27 22:16:12 volumio volumio[1264]: info: sendMpdCommand status took 1 milliseconds Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::parseState Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 22:16:12 volumio volumio[1264]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 22:16:12 volumio volumio[1264]: verbose: ControllerMpd::parseTrackInfo Dec 27 22:16:12 volumio volumio[1264]: info: ControllerMpd::pushState Dec 27 22:16:12 volumio volumio[1264]: info: CoreCommandRouter::servicePushState Dec 27 22:16:12 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:12 volumio volumio[1264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":205,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"POPPY, AMY LEE, COURTNEY LAPLANTE - End of You (Official Music Video)","artist":"SUMERIAN","album":"YouTube","uri":"https://rr4---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888171&ei=iz5QabbMKpnLi9oPpJOtkAY&ip=79.98.240.100&id=o-AKXKMuChFXeTyMTxRwFY3qj15ToO1n07wtdGKeL9moL9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=290&met=1766866571%2C&mh=Rn&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27snel&ms=au%2Crdu&mv=m&mvi=4&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3DRM0kJd9Ewzed6IisO8k2g-19K0Nx0baNPf_JpIqxQfyOTOuspFwGES9zSvtFoTrlVk86NLcz0&spc=wH4Qq0d_KdZBfvuGq3MQUY2qjGwZfl5DrosOo23Dh4xmoq7qKm-OVQ&vprv=1&svpuc=1&xtags=acont%3Doriginal%3Alang%3Den-US&mime=audio%2Fwebm&ns=Jzc_zIurPAcXZcPqUiiZcU0R&rqh=1&gir=yes&clen=3326309&dur=205.081&lmt=1756911242500159&mt=1766866191&fvip=9&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=3308224&n=TYU4g3NSG12kdA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAN2OMFW1HRbOkjb1xLgRw5pr79iGKX2OSWS5PlSk-L01AiAg-D3i0UYQqYQ3XJbLTIxhAiYhK9kpvR_eNz3Oo00NCw%3D%3D&sig=AJfQdSswRQIgfFs8WyHYstVtCvKmH4U7k4uqQu85omkr46X142VHxVsCIQCNOWyf0Hjc_cp8Cqm5m4PYSEOQUdhslO-1NtRCrCbZ8g%3D%3D&pot=MlWi35Cft42kh6Lhzf0sMZczzTtK8MaWrXMEXYAN9YTXYByn_6CK0Sd91BefhPHAzrgJnzBdT0ulPe5k3KOTK0fgID8dRkDJJdlFp1TY5gWgRRIAtQEo&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 27 22:16:12 volumio volumio[1264]: verbose: CURRENT POSITION 94 Dec 27 22:16:12 volumio volumio[1264]: info: CoreStateMachine::syncState stateService play Dec 27 22:16:12 volumio volumio[1264]: info: CoreStateMachine::syncState currentStatus stop Dec 27 22:16:12 volumio volumio[1264]: info: ------------------------------ 7ms Dec 27 22:16:17 volumio go-librespot[6780]: time="2025-12-27T22:16:17+02:00" level=trace msg="sent dealer ping" Dec 27 22:16:17 volumio go-librespot[6780]: time="2025-12-27T22:16:17+02:00" level=trace msg="received dealer pong" Dec 27 22:16:36 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 27 22:16:36 volumio volumio[1264]: info: [youtube2-browse] browseUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEstorefront%22%2C%22params%22%3A%22ogUCKAU%253D%22%7D%7D Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:37 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:41 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::volumioAddQueueItems Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::addQueueItems Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::addQueueItems Dec 27 22:16:41 volumio volumio[1264]: info: Preload queue cleared Dec 27 22:16:41 volumio volumio[1264]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Harry%20Potter%20and%20the%20Sorcerer's%20Stone%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi_webp%2F-ojN9LOtYF4%2Fmovieposter.webp%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22-ojN9LOtYF4%22%7D%7D%7D Dec 27 22:16:41 volumio volumio[1264]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Harry%20Potter%20and%20the%20Sorcerer's%20Stone%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi_webp%2F-ojN9LOtYF4%2Fmovieposter.webp%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22-ojN9LOtYF4%22%7D%7D%7D in service youtube2 Dec 27 22:16:41 volumio volumio[1264]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Harry%20Potter%20and%20the%20Sorcerer's%20Stone%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi_webp%2F-ojN9LOtYF4%2Fmovieposter.webp%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22-ojN9LOtYF4%22%7D%7D%7D Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::volumioPushQueue Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::saveQueue Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::updateTrackBlock Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrackBlock Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::volumioPlay Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::play index 118 Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::stop Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::stPlaybackTimer Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::updateTrackBlock Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrackBlock Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::pushState Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::serviceStop Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrack 94 Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::serviceStop Dec 27 22:16:41 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 27 22:16:41 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Disabled Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 22:16:41 volumio volumio[1264]: info: ControllerMpd::stop Dec 27 22:16:41 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 22:16:41 volumio volumio[1264]: info: Dec 27 22:16:41 volumio volumio[1264]: ---------------------------- MPD announces state update: player Dec 27 22:16:41 volumio volumio[1264]: info: sendMpdCommand stop took 39 milliseconds Dec 27 22:16:41 volumio volumio[1264]: info: ControllerMpd::getState Dec 27 22:16:41 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand status Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::play index undefined Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrack 118 Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::startPlaybackTimer Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrack 118 Dec 27 22:16:41 volumio volumio[1264]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22-ojN9LOtYF4%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Harry%20Potter%20and%20the%20Sorcerer's%20Stone%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi_webp%2F-ojN9LOtYF4%2Fmovieposter.webp%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22-ojN9LOtYF4%22%7D%7D%7D Dec 27 22:16:41 volumio volumio[1264]: info: sendMpdCommand status took 36 milliseconds Dec 27 22:16:41 volumio volumio[1264]: verbose: ControllerMpd::parseState Dec 27 22:16:41 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 22:16:41 volumio volumio[1264]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 27 22:16:41 volumio volumio[1264]: verbose: ControllerMpd::parseTrackInfo Dec 27 22:16:41 volumio volumio[1264]: info: ControllerMpd::pushState Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::servicePushState Dec 27 22:16:41 volumio volumio[1264]: info: CoreStateMachine::pushState Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrack 118 Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 22:16:41 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 27 22:16:41 volumio volumio[1264]: info: CorePlayQueue::getTrack 118 Dec 27 22:16:41 volumio volumio[1264]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 27 22:16:41 volumio volumio[1264]: info: ------------------------------ 59ms Dec 27 22:16:41 volumio volumio[1264]: info: [ytmusic] Obtained PO token for video #-ojN9LOtYF4: MlWpg1tmcfGwg6m9BgTqTYM3xmeBCQDquXcPAUv0M_jDZBf7NFlMrTN530tUfTe82rwCw_ukiTexOeU4F1pVV1PkK2PWv4a1Md2Yx91y8ZLlXFyreBav Dec 27 22:16:42 volumio volumio[1264]: info: [ytmusic] Obtained PO token for video #-ojN9LOtYF4: MlXKjvjXeU9YgcqwpbXi82s1pWoiuAhUUXVsDOhFO0YrZnT2l-hEE9t7vEb3zD8CMr5hzlgVgYlZO4Y1tOtd6bvmSG51Do4L2d8lJnZgNAbQnrwFZab8 Dec 27 22:16:42 volumio volumio[1264]: info: [youtube2] VideoModel.getInfo(-ojN9LOtYF4): validating stream URL "https://rr3---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888202&ei=qj5QafjxH_HQ6dsPwdSO0A4&ip=79.98.240.100&id=o-AOlY3nlQkhVjwUkle1a_tbx1QcQgSTPd5V1OFXndAss_&itag=140&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=47&met=1766866602%2C&mh=DK&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3Bw0CJZXBVkI_fc13kPLDU1xNGbyLy9WTqh7HzkRZyMduXeJKysM-Fgdz77q_4QFTT_3bcUeCVd&spc=wH4Qq2ix5nrpR2HdV2vkxpdoY-cjEAQbegnnKupzikFlgfhd8B3jtqdIC9k&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=ORretBizcKj8ZTqmUPzDe5sR&rqh=1&gir=yes&clen=2325961&dur=141.200&lmt=1558242687884292&mt=1766866191&fvip=18&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&n=t8ay_tF94fKxGw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAPmIp6MJiZAq3KhDMCbUz0k64uTaqZc8P_HDYrrd0HE_AiAYKFzOAG1mJtmZFA4nriHozFjZsV56kncTajSON26ogg%3D%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhALyrrWcQtXzwRfQpx5pdujNguUIZoM6NpyydJWpGZDioAiEA_WEpofHdhSDhUj9YiS2q5CP4ifTDfV4uOb1ZkbW1dq8%3D&pot=MlXKjvjXeU9YgcqwpbXi82s1pWoiuAhUUXVsDOhFO0YrZnT2l-hEE9t7vEb3zD8CMr5hzlgVgYlZO4Y1tOtd6bvmSG51Do4L2d8lJnZgNAbQnrwFZab8&cver=1.20250219.01.00"... Dec 27 22:16:42 volumio volumio[1264]: info: [youtube2] VideoModel.getInfo(-ojN9LOtYF4): stream validated in 0.078s. Dec 27 22:16:42 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 27 22:16:42 volumio volumio[1264]: info: [youtube2] (AutoplayManager) Enabled Dec 27 22:16:42 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 22:16:42 volumio volumio[1264]: info: sendMpdCommand stop took 2 milliseconds Dec 27 22:16:42 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand clear Dec 27 22:16:42 volumio volumio[1264]: info: Dec 27 22:16:42 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:16:42 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:16:42 volumio volumio[1264]: info: sendMpdCommand clear took 1 milliseconds Dec 27 22:16:42 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888202&ei=qj5QafjxH_HQ6dsPwdSO0A4&ip=79.98.240.100&id=o-AOlY3nlQkhVjwUkle1a_tbx1QcQgSTPd5V1OFXndAss_&itag=140&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=47&met=1766866602%2C&mh=DK&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3Bw0CJZXBVkI_fc13kPLDU1xNGbyLy9WTqh7HzkRZyMduXeJKysM-Fgdz77q_4QFTT_3bcUeCVd&spc=wH4Qq2ix5nrpR2HdV2vkxpdoY-cjEAQbegnnKupzikFlgfhd8B3jtqdIC9k&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=ORretBizcKj8ZTqmUPzDe5sR&rqh=1&gir=yes&clen=2325961&dur=141.200&lmt=1558242687884292&mt=1766866191&fvip=18&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&n=t8ay_tF94fKxGw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAPmIp6MJiZAq3KhDMCbUz0k64uTaqZc8P_HDYrrd0HE_AiAYKFzOAG1mJtmZFA4nriHozFjZsV56kncTajSON26ogg%3D%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhALyrrWcQtXzwRfQpx5pdujNguUIZoM6NpyydJWpGZDioAiEA_WEpofHdhSDhUj9YiS2q5CP4ifTDfV4uOb1ZkbW1dq8%3D&pot=MlXKjvjXeU9YgcqwpbXi82s1pWoiuAhUUXVsDOhFO0YrZnT2l-hEE9t7vEb3zD8CMr5hzlgVgYlZO4Y1tOtd6bvmSG51Do4L2d8lJnZgNAbQnrwFZab8&cver=1.20250219.01.00&t.YouTube" Dec 27 22:16:42 volumio volumio[1264]: error: updateQueue error: null Dec 27 22:16:42 volumio volumio[1264]: info: ------------------------------ 2ms Dec 27 22:16:42 volumio volumio[1264]: info: Dec 27 22:16:42 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:16:42 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:16:42 volumio volumio[1264]: info: sendMpdCommand addid "https://rr3---sn-vhxb5uxax03g-px8e.googlevideo.com/videoplayback?expire=1766888202&ei=qj5QafjxH_HQ6dsPwdSO0A4&ip=79.98.240.100&id=o-AOlY3nlQkhVjwUkle1a_tbx1QcQgSTPd5V1OFXndAss_&itag=140&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=47&met=1766866602%2C&mh=DK&mm=31%2C29&mn=sn-vhxb5uxax03g-px8e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=3&pl=23&rms=au%2Cau&initcwndbps=1568750&bui=AYUSA3Bw0CJZXBVkI_fc13kPLDU1xNGbyLy9WTqh7HzkRZyMduXeJKysM-Fgdz77q_4QFTT_3bcUeCVd&spc=wH4Qq2ix5nrpR2HdV2vkxpdoY-cjEAQbegnnKupzikFlgfhd8B3jtqdIC9k&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=ORretBizcKj8ZTqmUPzDe5sR&rqh=1&gir=yes&clen=2325961&dur=141.200&lmt=1558242687884292&mt=1766866191&fvip=18&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&n=t8ay_tF94fKxGw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAPmIp6MJiZAq3KhDMCbUz0k64uTaqZc8P_HDYrrd0HE_AiAYKFzOAG1mJtmZFA4nriHozFjZsV56kncTajSON26ogg%3D%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhALyrrWcQtXzwRfQpx5pdujNguUIZoM6NpyydJWpGZDioAiEA_WEpofHdhSDhUj9YiS2q5CP4ifTDfV4uOb1ZkbW1dq8%3D&pot=MlXKjvjXeU9YgcqwpbXi82s1pWoiuAhUUXVsDOhFO0YrZnT2l-hEE9t7vEb3zD8CMr5hzlgVgYlZO4Y1tOtd6bvmSG51Do4L2d8lJnZgNAbQnrwFZab8&cver=1.20250219.01.00&t.YouTube" took 2 milliseconds Dec 27 22:16:42 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:16:42 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:16:42 volumio volumio[1264]: verbose: MPD COMMAND [object Object] Dec 27 22:16:42 volumio volumio[1264]: info: Dec 27 22:16:42 volumio volumio[1264]: ---------------------------- MPD announces system playlist update Dec 27 22:16:42 volumio volumio[1264]: info: Ignoring MPD Status Update Dec 27 22:16:42 volumio volumio[1264]: info: ------------------------------ 3ms Dec 27 22:16:42 volumio volumio[1264]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 22:16:42 volumio volumio[1264]: verbose: ControllerMpd::sendMpdCommand play Dec 27 22:16:42 volumio volumio[1264]: info: ------------------------------ 3ms Dec 27 22:16:42 volumio volumio[1264]: info: sendMpdCommand play took 2 milliseconds Dec 27 22:16:42 volumio volumio[1264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 22:16:42 volumio volumio[1264]: InnertubeError: Playback tracking not available Dec 27 22:16:42 volumio volumio[1264]: at _VideoInfo.addToWatchHistory (/data/plugins/music_service/youtube2/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:30709:13) Dec 27 22:16:42 volumio volumio[1264]: at _VideoInfo.addToWatchHistory (/data/plugins/music_service/youtube2/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:32099:18) Dec 27 22:16:42 volumio volumio[1264]: at Object.addToHistory (/data/plugins/music_service/youtube2/dist/lib/model/VideoModel.js:66:34) Dec 27 22:16:42 volumio volumio[1264]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/youtube2/dist/lib/controller/play/PlayController.js:141:35) Dec 27 22:16:42 volumio volumio[1264]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Dec 27 22:16:42 volumio volumio[1264]: date: 2025-12-27T20:16:42.830Z, Dec 27 22:16:42 volumio volumio[1264]: version: '1.6.0', Dec 27 22:16:42 volumio volumio[1264]: info: undefined Dec 27 22:16:42 volumio volumio[1264]: } Dec 27 22:16:42 volumio volumio[1264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 22:16:43 volumio sudo[8803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-27 22:15' Dec 27 22:16:43 volumio sudo[8803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"