Dec 26 11:36:12 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::ClearQueue Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::stPlaybackTimer Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::updateTrackBlock Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::getTrackBlock Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::serviceStop Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::serviceStop Dec 26 11:36:12 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Dec 26 11:36:12 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 26 11:36:12 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Disabled Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::stop Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::clearPlayQueue Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::saveQueue Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushQueue Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::addQueueItems Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::addQueueItems Dec 26 11:36:12 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:36:12 volumio volumio[1207]: 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%2C%22params%22%3A%22EghmZWF0dXJlZPIGBAoCMgA%253D%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_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%7D%7D%7D Dec 26 11:36:12 volumio volumio[1207]: 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%2C%22params%22%3A%22EghmZWF0dXJlZPIGBAoCMgA%253D%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_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%7D%7D%7D in service youtube2 Dec 26 11:36:12 volumio volumio[1207]: 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%2C%22params%22%3A%22EghmZWF0dXJlZPIGBAoCMgA%253D%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_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%7D%7D%7D Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand stop took 30 milliseconds Dec 26 11:36:12 volumio volumio[1207]: info: Dec 26 11:36:12 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:12 volumio volumio[1207]: info: Dec 26 11:36:12 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:12 volumio volumio[1207]: info: Dec 26 11:36:12 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand status took 3 milliseconds Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand status took 3 milliseconds Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand status took 2 milliseconds Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:12 volumio volumio[1207]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mariah Carey - All I Want for Christmas Is You (Make My Wish Come True Edition)","artist":"MariahCareyVEVO","album":"YouTube","uri":"https://rr4---sn-hpa7znz6.googlevideo.com/videoplayback?expire=1766766922&ei=6mROacmWBvml6dsP4MXHaA&ip=37.161.238.238&id=o-ALbOEJ79v07P09buJSJFgzACIbQB4qPXnfPrEn8x5Fdn&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=761&met=1766745322%2C&mh=to&mm=31%2C26&mn=sn-hpa7znz6%2Csn-hgn7rn7r&ms=au%2Conr&mv=m&mvi=4&pl=16&rms=au%2Cau&gcr=it&initcwndbps=1605000&bui=AYUSA3B2ZwNtc1X05tshsc99NtgLs-iibT4tNX_b1ai8gTw3KedNATmgUuAQ5PKeng9M-V5D7EZpM1mR&spc=wH4QqxlxnM1Nqjp1oAABrfkcXeKAleEcFVOWkFTafC1pWB9j742IMA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Yly1koL350bmo3V97ELyQoUR&rqh=1&gir=yes&clen=3907279&dur=242.881&lmt=1714705242909120&mt=1766744698&fvip=3&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=JOj04AK_biPDBA&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=APaTxxMwRAIgCPY1c3Hfqlxxt5nEHXiTYgVsf6CiQHLWgkwKLOWS6awCIFZyGQ_nKTSDo2mPVc69SV89N609N1YYiEjoDxaY-5fe&sig=AJfQdSswRQIhAMc9F7ReSy5DPo6qCTLoNaRi23OmdReMhOCfS6ORg4ZuAiBGgBKaPtCon5e19v5kTnQ_rqyVJMpUhHJ7t9ZGPbUlOQ%3D%3D&pot=MlXyhpj-FjQPUfK4PTpL8xf41GNRRX7VZob6hJcQZzIkOeRgoY2MHrsoINmyl5u3yxbIsPYPxdI8-uwir6uui1DLQcALO8AAvs5n4J98RbFs4QzUi2kH&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:12 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::syncState stateService stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: No code Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:12 volumio volumio[1207]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mariah Carey - All I Want for Christmas Is You (Make My Wish Come True Edition)","artist":"MariahCareyVEVO","album":"YouTube","uri":"https://rr4---sn-hpa7znz6.googlevideo.com/videoplayback?expire=1766766922&ei=6mROacmWBvml6dsP4MXHaA&ip=37.161.238.238&id=o-ALbOEJ79v07P09buJSJFgzACIbQB4qPXnfPrEn8x5Fdn&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=761&met=1766745322%2C&mh=to&mm=31%2C26&mn=sn-hpa7znz6%2Csn-hgn7rn7r&ms=au%2Conr&mv=m&mvi=4&pl=16&rms=au%2Cau&gcr=it&initcwndbps=1605000&bui=AYUSA3B2ZwNtc1X05tshsc99NtgLs-iibT4tNX_b1ai8gTw3KedNATmgUuAQ5PKeng9M-V5D7EZpM1mR&spc=wH4QqxlxnM1Nqjp1oAABrfkcXeKAleEcFVOWkFTafC1pWB9j742IMA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Yly1koL350bmo3V97ELyQoUR&rqh=1&gir=yes&clen=3907279&dur=242.881&lmt=1714705242909120&mt=1766744698&fvip=3&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=JOj04AK_biPDBA&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=APaTxxMwRAIgCPY1c3Hfqlxxt5nEHXiTYgVsf6CiQHLWgkwKLOWS6awCIFZyGQ_nKTSDo2mPVc69SV89N609N1YYiEjoDxaY-5fe&sig=AJfQdSswRQIhAMc9F7ReSy5DPo6qCTLoNaRi23OmdReMhOCfS6ORg4ZuAiBGgBKaPtCon5e19v5kTnQ_rqyVJMpUhHJ7t9ZGPbUlOQ%3D%3D&pot=MlXyhpj-FjQPUfK4PTpL8xf41GNRRX7VZob6hJcQZzIkOeRgoY2MHrsoINmyl5u3yxbIsPYPxdI8-uwir6uui1DLQcALO8AAvs5n4J98RbFs4QzUi2kH&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:12 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::syncState stateService stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: No code Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: ------------------------------ 27ms Dec 26 11:36:12 volumio volumio[1207]: info: ------------------------------ 27ms Dec 26 11:36:12 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 23 milliseconds Dec 26 11:36:12 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:12 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:12 volumio volumio[1207]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mariah Carey - All I Want for Christmas Is You (Make My Wish Come True Edition)","artist":"MariahCareyVEVO","album":"YouTube","uri":"https://rr4---sn-hpa7znz6.googlevideo.com/videoplayback?expire=1766766922&ei=6mROacmWBvml6dsP4MXHaA&ip=37.161.238.238&id=o-ALbOEJ79v07P09buJSJFgzACIbQB4qPXnfPrEn8x5Fdn&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=761&met=1766745322%2C&mh=to&mm=31%2C26&mn=sn-hpa7znz6%2Csn-hgn7rn7r&ms=au%2Conr&mv=m&mvi=4&pl=16&rms=au%2Cau&gcr=it&initcwndbps=1605000&bui=AYUSA3B2ZwNtc1X05tshsc99NtgLs-iibT4tNX_b1ai8gTw3KedNATmgUuAQ5PKeng9M-V5D7EZpM1mR&spc=wH4QqxlxnM1Nqjp1oAABrfkcXeKAleEcFVOWkFTafC1pWB9j742IMA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Yly1koL350bmo3V97ELyQoUR&rqh=1&gir=yes&clen=3907279&dur=242.881&lmt=1714705242909120&mt=1766744698&fvip=3&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=JOj04AK_biPDBA&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=APaTxxMwRAIgCPY1c3Hfqlxxt5nEHXiTYgVsf6CiQHLWgkwKLOWS6awCIFZyGQ_nKTSDo2mPVc69SV89N609N1YYiEjoDxaY-5fe&sig=AJfQdSswRQIhAMc9F7ReSy5DPo6qCTLoNaRi23OmdReMhOCfS6ORg4ZuAiBGgBKaPtCon5e19v5kTnQ_rqyVJMpUhHJ7t9ZGPbUlOQ%3D%3D&pot=MlXyhpj-FjQPUfK4PTpL8xf41GNRRX7VZob6hJcQZzIkOeRgoY2MHrsoINmyl5u3yxbIsPYPxdI8-uwir6uui1DLQcALO8AAvs5n4J98RbFs4QzUi2kH&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:12 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::syncState stateService stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: No code Dec 26 11:36:12 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:12 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:12 volumio volumio[1207]: info: ------------------------------ 36ms Dec 26 11:36:14 volumio volumio[1207]: info: CoreCommandRouter::volumioPushQueue Dec 26 11:36:14 volumio volumio[1207]: info: CorePlayQueue::saveQueue Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::updateTrackBlock Dec 26 11:36:14 volumio volumio[1207]: info: CorePlayQueue::getTrackBlock Dec 26 11:36:14 volumio volumio[1207]: info: CoreCommandRouter::volumioPlay Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::play index 0 Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::stop Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::play index undefined Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:14 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:14 volumio volumio[1207]: info: CoreStateMachine::startPlaybackTimer Dec 26 11:36:14 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:14 volumio volumio[1207]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%221AnSHYjQ3tc%22%2C%22playlistId%22%3A%22RDCLAK5uy_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Phil%20Wickham%20-%20What%20An%20Awesome%20God%20(Sunset%20Walk)%22%2C%22artist%22%3A%22Phil%20Wickham%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F1AnSHYjQ3tc%2Fhqdefault.jpg%3Fsqp%3D-oaymwEjCNACELwBSFryq4qpAxUIARUAAAAAGAElAADIQj0AgKJDeAE%3D%26rs%3DAOn4CLDTpHjJGm7PSrN1WW7gtR_dKyYO_A%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%221AnSHYjQ3tc%22%2C%22playlistId%22%3A%22RDCLAK5uy_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Dec 26 11:36:14 volumio volumio[1207]: info: [ytmusic] Obtained PO token for video #1AnSHYjQ3tc: MlWrHKHGxuD2Z6siBAKbJ-7Ojflofa4Bn7CjHq4ot-bdD736mLVcykIeeUOLr0tjMiCRKs83FQbFzLW4lpN-X6n9GFoyAxDUR_hMk7tFLfwCgbRZy9ie Dec 26 11:36:15 volumio volumio[1207]: info: [ytmusic] Obtained PO token for video #1AnSHYjQ3tc: MlWKImR44JUFloocwby9Uh0_rMetw4h0bEGCIGuWkZMu_pzEXQt6v7HvWH1OEW0WwdGwFAqJM3M2PZSGUy1YKloMOWT3vTahtAn4EpmT4C6sT4AZWSki Dec 26 11:36:15 volumio volumio[1207]: info: [youtube2] VideoModel.getInfo(1AnSHYjQ3tc): validating stream URL "https://rr5---sn-hpa7znzr.googlevideo.com/videoplayback?expire=1766766975&ei=H2VOaZnAHLSCi9oPpIa6yQo&ip=37.161.238.238&id=o-AL9UYuKt_CZAb3TCac7M6pjGYGaiSalVvpKA8uGGQuZ5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=340&met=1766745375%2C&mh=qS&mm=31%2C26&mn=sn-hpa7znzr%2Csn-hgn7yn7e&ms=au%2Conr&mv=m&mvi=5&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ARQC-VCQElUMMz3jtxOlXaEYDQZ6IdRLnTo3HqYsCJz4qr54kvxY6rwkZsiXR1f-v_C7gf3UOG&spc=wH4Qq39O1PKXvUn-0pk_ErI-a9zX1zdMb-pbiAIDLZrZg93rXjeGSQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=E5S5YstV80sVsdIUDlTdCIAR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=3&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=_K28n-vA-2rpLg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAOrMn5_jyj8adFypDb3Nb2SGZ74lnSkXZUaN97rLvLFBAiEA3NRoEo3zNrGjDxB74xSouNw9eUrhBQx9TGoS5cgIOkw%3D&sig=AJfQdSswRQIgM3JgbhU94lykysLISv2tR_EtMdzEG3Z01RCrlaOV3wQCIQD6I66meTUDykfaQbKtHX_YXu5J5akqCB5efe1DGxVcWQ%3D%3D&pot=MlWKImR44JUFloocwby9Uh0_rMetw4h0bEGCIGuWkZMu_pzEXQt6v7HvWH1OEW0WwdGwFAqJM3M2PZSGUy1YKloMOWT3vTahtAn4EpmT4C6sT4AZWSki&cver=1.20250219.01.00"... Dec 26 11:36:16 volumio volumio[1207]: info: [youtube2] VideoModel.getInfo(1AnSHYjQ3tc): stream validated in 0.454s. Dec 26 11:36:16 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 26 11:36:16 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Enabled Dec 26 11:36:16 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 11:36:16 volumio volumio[1207]: info: sendMpdCommand stop took 2 milliseconds Dec 26 11:36:16 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand clear Dec 26 11:36:16 volumio volumio[1207]: info: sendMpdCommand clear took 1 milliseconds Dec 26 11:36:16 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand addid "https://rr5---sn-hpa7znzr.googlevideo.com/videoplayback?expire=1766766975&ei=H2VOaZnAHLSCi9oPpIa6yQo&ip=37.161.238.238&id=o-AL9UYuKt_CZAb3TCac7M6pjGYGaiSalVvpKA8uGGQuZ5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=340&met=1766745375%2C&mh=qS&mm=31%2C26&mn=sn-hpa7znzr%2Csn-hgn7yn7e&ms=au%2Conr&mv=m&mvi=5&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ARQC-VCQElUMMz3jtxOlXaEYDQZ6IdRLnTo3HqYsCJz4qr54kvxY6rwkZsiXR1f-v_C7gf3UOG&spc=wH4Qq39O1PKXvUn-0pk_ErI-a9zX1zdMb-pbiAIDLZrZg93rXjeGSQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=E5S5YstV80sVsdIUDlTdCIAR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=3&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=_K28n-vA-2rpLg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAOrMn5_jyj8adFypDb3Nb2SGZ74lnSkXZUaN97rLvLFBAiEA3NRoEo3zNrGjDxB74xSouNw9eUrhBQx9TGoS5cgIOkw%3D&sig=AJfQdSswRQIgM3JgbhU94lykysLISv2tR_EtMdzEG3Z01RCrlaOV3wQCIQD6I66meTUDykfaQbKtHX_YXu5J5akqCB5efe1DGxVcWQ%3D%3D&pot=MlWKImR44JUFloocwby9Uh0_rMetw4h0bEGCIGuWkZMu_pzEXQt6v7HvWH1OEW0WwdGwFAqJM3M2PZSGUy1YKloMOWT3vTahtAn4EpmT4C6sT4AZWSki&cver=1.20250219.01.00&t.YouTube" Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: sendMpdCommand addid "https://rr5---sn-hpa7znzr.googlevideo.com/videoplayback?expire=1766766975&ei=H2VOaZnAHLSCi9oPpIa6yQo&ip=37.161.238.238&id=o-AL9UYuKt_CZAb3TCac7M6pjGYGaiSalVvpKA8uGGQuZ5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=340&met=1766745375%2C&mh=qS&mm=31%2C26&mn=sn-hpa7znzr%2Csn-hgn7yn7e&ms=au%2Conr&mv=m&mvi=5&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ARQC-VCQElUMMz3jtxOlXaEYDQZ6IdRLnTo3HqYsCJz4qr54kvxY6rwkZsiXR1f-v_C7gf3UOG&spc=wH4Qq39O1PKXvUn-0pk_ErI-a9zX1zdMb-pbiAIDLZrZg93rXjeGSQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=E5S5YstV80sVsdIUDlTdCIAR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=3&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=_K28n-vA-2rpLg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAOrMn5_jyj8adFypDb3Nb2SGZ74lnSkXZUaN97rLvLFBAiEA3NRoEo3zNrGjDxB74xSouNw9eUrhBQx9TGoS5cgIOkw%3D&sig=AJfQdSswRQIgM3JgbhU94lykysLISv2tR_EtMdzEG3Z01RCrlaOV3wQCIQD6I66meTUDykfaQbKtHX_YXu5J5akqCB5efe1DGxVcWQ%3D%3D&pot=MlWKImR44JUFloocwby9Uh0_rMetw4h0bEGCIGuWkZMu_pzEXQt6v7HvWH1OEW0WwdGwFAqJM3M2PZSGUy1YKloMOWT3vTahtAn4EpmT4C6sT4AZWSki&cver=1.20250219.01.00&t.YouTube" took 4 milliseconds Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 4ms Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 4ms Dec 26 11:36:16 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:36:16 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:36:16 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 7ms Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 7ms Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 4ms Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 26 11:36:16 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand play Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: Dec 26 11:36:16 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:16 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 6ms Dec 26 11:36:16 volumio volumio[1207]: info: sendMpdCommand play took 4 milliseconds Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:36:16 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:36:16 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:36:16 volumio volumio[1207]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::ClearQueue Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::stop Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::clearPlayQueue Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::saveQueue Dec 26 11:36:16 volumio volumio[1207]: info: CoreCommandRouter::volumioPushQueue Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::addQueueItems Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::addQueueItems Dec 26 11:36:16 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:36:16 volumio volumio[1207]: 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%2C%22params%22%3A%22EghmZWF0dXJlZPIGBAoCMgA%253D%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_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%7D%7D%7D Dec 26 11:36:16 volumio volumio[1207]: info: Using cached record of: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%2C%22params%22%3A%22EghmZWF0dXJlZPIGBAoCMgA%253D%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_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%7D%7D%7D Dec 26 11:36:16 volumio volumio[1207]: info: CoreCommandRouter::volumioPushQueue Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::saveQueue Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::updateTrackBlock Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::getTrackBlock Dec 26 11:36:16 volumio volumio[1207]: info: CoreCommandRouter::volumioPlay Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::play index 0 Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::stop Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::play index undefined Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:16 volumio volumio[1207]: info: CoreStateMachine::startPlaybackTimer Dec 26 11:36:16 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:16 volumio volumio[1207]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%221AnSHYjQ3tc%22%2C%22playlistId%22%3A%22RDCLAK5uy_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Phil%20Wickham%20-%20What%20An%20Awesome%20God%20(Sunset%20Walk)%22%2C%22artist%22%3A%22Phil%20Wickham%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F1AnSHYjQ3tc%2Fhqdefault.jpg%3Fsqp%3D-oaymwEjCNACELwBSFryq4qpAxUIARUAAAAAGAElAADIQj0AgKJDeAE%3D%26rs%3DAOn4CLDTpHjJGm7PSrN1WW7gtR_dKyYO_A%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%221AnSHYjQ3tc%22%2C%22playlistId%22%3A%22RDCLAK5uy_mU14EejSbDsfLuPc9KpNzoC0o-YQvi6I4%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Dec 26 11:36:16 volumio volumio[1207]: info: [ytmusic] Obtained PO token for video #1AnSHYjQ3tc: MlUTnzLT91BTaxOhlxeql0vCNXr7aJ-xOrwbnT09hlZ4AwV5C6BteucSwcAYunrTlywpqVwiJLZgwA07BYZP7wzxoNmhFiFk4vSBpLJTvbztCUy97t2t Dec 26 11:36:17 volumio volumio[1207]: info: [ytmusic] Obtained PO token for video #1AnSHYjQ3tc: MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 27 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 28 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 28 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 3 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 34ms Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 7 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 36ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 35ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 11ms Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 11ms Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 7ms Dec 26 11:36:17 volumio volumio[1207]: info: [youtube2] VideoModel.getInfo(1AnSHYjQ3tc): validating stream URL "https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00"... Dec 26 11:36:17 volumio volumio[1207]: info: [youtube2] VideoModel.getInfo(1AnSHYjQ3tc): stream validated in 0.396s. Dec 26 11:36:17 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Enabled Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand stop took 18 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand clear Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: error: updateQueue error: null Dec 26 11:36:17 volumio volumio[1207]: error: updateQueue error: null Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand clear took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 4 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand status took 3 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 2ms Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube" Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:17 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:17 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 13ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 12ms Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: error: updateQueue error: null Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 13ms Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand addid "https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube" took 12 milliseconds Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 4ms Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:17 volumio volumio[1207]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 11:36:17 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:36:17 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:36:17 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 21ms Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: Dec 26 11:36:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:36:17 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 11ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 10ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 2ms Dec 26 11:36:17 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 26 11:36:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand play Dec 26 11:36:17 volumio volumio[1207]: info: ------------------------------ 2ms Dec 26 11:36:17 volumio volumio[1207]: info: sendMpdCommand play took 2 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: Dec 26 11:36:19 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:19 volumio volumio[1207]: info: Dec 26 11:36:19 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:19 volumio volumio[1207]: info: Dec 26 11:36:19 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:19 volumio volumio[1207]: info: Dec 26 11:36:19 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:19 volumio volumio[1207]: info: Dec 26 11:36:19 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand status took 29 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand status took 28 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand status took 28 milliseconds Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:19 volumio volumio[1207]: info: Dec 26 11:36:19 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand status took 5 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand status took 4 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand status took 2 milliseconds Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:19 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phil Wickham - What An Awesome God (Sunset Walk)","artist":"Phil Wickham","album":"YouTube","uri":"https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:19 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState stateService play Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:19 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phil Wickham - What An Awesome God (Sunset Walk)","artist":"Phil Wickham","album":"YouTube","uri":"https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:19 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState stateService play Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus play Dec 26 11:36:19 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Added mpdStateListener Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:19 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phil Wickham - What An Awesome God (Sunset Walk)","artist":"Phil Wickham","album":"YouTube","uri":"https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:19 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState stateService play Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus play Dec 26 11:36:19 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: ------------------------------ 49ms Dec 26 11:36:19 volumio volumio[1207]: info: ------------------------------ 50ms Dec 26 11:36:19 volumio volumio[1207]: info: ------------------------------ 50ms Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 26 11:36:19 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:19 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:19 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phil Wickham - What An Awesome God (Sunset Walk)","artist":"Phil Wickham","album":"YouTube","uri":"https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:19 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState stateService play Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus play Dec 26 11:36:19 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:19 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phil Wickham - What An Awesome God (Sunset Walk)","artist":"Phil Wickham","album":"YouTube","uri":"https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:19 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState stateService play Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus play Dec 26 11:36:19 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:36:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:36:19 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Phil Wickham - What An Awesome God (Sunset Walk)","artist":"Phil Wickham","album":"YouTube","uri":"https://rr3---sn-hpa7kn7d.googlevideo.com/videoplayback?expire=1766766977&ei=IWVOabLVEv_bmLAPxdKo0Q8&ip=37.161.238.238&id=o-AH-FIHPj1ZvD662sDnROjjaHjFnuDtXhMOUN3T2F7fO2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=33&met=1766745377%2C&mh=qS&mm=31%2C29&mn=sn-hpa7kn7d%2Csn-hpa7znzr&ms=au%2Crdu&mv=m&mvi=3&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3ApuFi9xHtDTa40zrVDFuf7RLhXFWPcxkjEi6YaCo1vklFdHYA5esalX8Uw96pJym8B8MIa82xK&spc=wH4Qq2dzt18V3pBK8Hobnv4FMy2eGfXMVWCAmI1b7eyRNr0J22iagw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZK9b4V8_z8sQrN_EyDQ7zPIR&rqh=1&gir=yes&clen=3638374&dur=213.241&lmt=1756651108614640&mt=1766744942&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=LFalJrOhtFUShg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgaAPjVtE_Ay3et1t_mtaV2_EVsTTLKYucVGUSx4z5GmMCIQDQgyp8aQavFVALpvWysxwRY7ZAywU_OjH1-sOxvPtxzw%3D%3D&sig=AJfQdSswRAIgZKLzQJas_h9yqm4eqpBNN_oIwJ_DoufSamfJnGC-7AwCIACiI00KDupbogsIQzREv30K5ofuy3lkX8koMfMyfUdF&pot=MlU1t-0vilX9WTWJSOvXkuXwE1IklOK0lI49teLB-1PWMSNR1FwQf0kg5-jHRgfWOR4PgYPeWbPO8isT2noy6qLDhvF-6lxhTMZCJ_HMSQlnBne9PjgC&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 26 11:36:19 volumio volumio[1207]: verbose: CURRENT POSITION 0 Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState stateService play Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::syncState currentStatus play Dec 26 11:36:19 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:19 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:19 volumio volumio[1207]: info: ------------------------------ 40ms Dec 26 11:36:19 volumio volumio[1207]: info: ------------------------------ 40ms Dec 26 11:36:19 volumio volumio[1207]: info: ------------------------------ 38ms Dec 26 11:36:34 volumio volumio[1207]: info: VolumeController::SetAlsaVolume24 Dec 26 11:36:34 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:34 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:34 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:34 volumio volumio[1207]: info: VolumeController::SetAlsaVolume34 Dec 26 11:36:34 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:34 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:34 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:38 volumio volumio[1207]: info: VolumeController::SetAlsaVolume27 Dec 26 11:36:38 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:38 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:38 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:38 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 26 11:36:39 volumio volumio[1207]: info: VolumeController::SetAlsaVolume20 Dec 26 11:36:39 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:39 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:39 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:40 volumio volumio[1207]: info: VolumeController::SetAlsaVolume26 Dec 26 11:36:40 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:40 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:40 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:40 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 26 11:36:40 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 26 11:36:51 volumio volumio[1207]: info: VolumeController::SetAlsaVolume- Dec 26 11:36:51 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:51 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:51 volumio volumio[1207]: info: VolumeController::SetAlsaVolume- Dec 26 11:36:51 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:51 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:51 volumio volumio[1207]: info: VolumeController::SetAlsaVolume- Dec 26 11:36:51 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:51 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:52 volumio volumio[1207]: info: VolumeController::SetAlsaVolume- Dec 26 11:36:52 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:52 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:52 volumio volumio[1207]: info: VolumeController::SetAlsaVolume- Dec 26 11:36:52 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:52 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:36:53 volumio volumio[1207]: info: VolumeController::SetAlsaVolume- Dec 26 11:36:53 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:36:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:36:53 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:37:01 volumio volumio[1207]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 11:37:01 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 11:37:01 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 11:37:02 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 11:37:02 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 11:37:43 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 26 11:37:43 volumio volumio[1207]: 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 26 11:37:44 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:37:44 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:37:44 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:37:47 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::ClearQueue Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::stop Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::stPlaybackTimer Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::updateTrackBlock Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrackBlock Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::serviceStop Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::serviceStop Dec 26 11:37:47 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Dec 26 11:37:47 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 26 11:37:47 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Disabled Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::stop Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::clearPlayQueue Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::saveQueue Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPushQueue Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::addQueueItems Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::addQueueItems Dec 26 11:37:47 volumio volumio[1207]: info: Preload queue cleared Dec 26 11:37:47 volumio volumio[1207]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22A%20Minecraft%20Movie%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FadsoQOm3qP4%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22adsoQOm3qP4%22%7D%7D%7D Dec 26 11:37:47 volumio volumio[1207]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22A%20Minecraft%20Movie%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FadsoQOm3qP4%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22adsoQOm3qP4%22%7D%7D%7D in service youtube2 Dec 26 11:37:47 volumio volumio[1207]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22A%20Minecraft%20Movie%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FadsoQOm3qP4%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22adsoQOm3qP4%22%7D%7D%7D Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPushQueue Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::saveQueue Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::updateTrackBlock Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrackBlock Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPlay Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::play index 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::stop Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::play index undefined Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::startPlaybackTimer Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22adsoQOm3qP4%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22A%20Minecraft%20Movie%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FadsoQOm3qP4%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22adsoQOm3qP4%22%7D%7D%7D Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand stop took 25 milliseconds Dec 26 11:37:47 volumio volumio[1207]: info: Dec 26 11:37:47 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:37:47 volumio volumio[1207]: info: Dec 26 11:37:47 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:37:47 volumio volumio[1207]: info: Dec 26 11:37:47 volumio volumio[1207]: ---------------------------- MPD announces state update: player Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::getState Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand status took 3 milliseconds Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand status took 2 milliseconds Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand status took 2 milliseconds Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::parseState Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 11:37:47 volumio volumio[1207]: info: [ytmusic] Obtained PO token for video #adsoQOm3qP4: MlVdr2pg8UpSFF2Rz6SsjUq9e0qj25mrO8NVrWWOgEx5fEtJUxNrYOZtj_BACXzJllNnmQSRIqxhv0MLXTVJ9Q2O7un5pSd-44uKOoPJD2ul4EoaSKtT Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 26 11:37:47 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:37:47 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:37:47 volumio volumio[1207]: info: ControllerMpd::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::servicePushState Dec 26 11:37:47 volumio volumio[1207]: info: CoreStateMachine::pushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState Dec 26 11:37:47 volumio volumio[1207]: info: CorePlayQueue::getTrack 0 Dec 26 11:37:47 volumio volumio[1207]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 26 11:37:47 volumio volumio[1207]: info: ------------------------------ 23ms Dec 26 11:37:47 volumio volumio[1207]: info: ------------------------------ 23ms Dec 26 11:37:47 volumio volumio[1207]: info: ------------------------------ 21ms Dec 26 11:37:48 volumio volumio[1207]: info: [ytmusic] Obtained PO token for video #adsoQOm3qP4: MlVJhTojbiKt60m7n-cz5bVCb2DzmAbDxDxBhzXNHySGg19jA1D0CBmSm9oQSuOhaaxzs1TSvcSeQFchDXbWnfJx-sOp5rgWHHTZaDm2Wj8MoM41dRTH Dec 26 11:37:48 volumio volumio[1207]: info: [youtube2] VideoModel.getInfo(adsoQOm3qP4): validating stream URL "https://rr1---sn-hpa7zn6z.googlevideo.com/videoplayback?expire=1766767068&ei=fGVOaYfKIq2I6dsP4--GyQs&ip=37.161.238.238&id=o-ABWBl9UKYInmmyOsFtL26aL1R6OjZbdClEQhv1H6ZYA0&itag=18&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766745468%2C&mh=S6&mm=31%2C26&mn=sn-hpa7zn6z%2Csn-hgn7rn7y&ms=au%2Conr&mv=m&mvi=1&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3CCllcRpDAOCTj91bQqtTpOEVwKhHbwp0iwUOrE_Xpf-ZhKi9_ChN4XcZ7kyjbIkkIfCxn2QSbL&spc=wH4Qq-JB7HUDyLGO8dZYspiabZRvdh0cx3PRfOroAflHZTEa_QDAo2-6uetvEg&vprv=1&svpuc=1&xtags=acont%3Ddubbed%3Alang%3Dit&mime=video%2Fmp4&ns=EUCZik4uu0P7q4ycv-yhW0IR&rqh=1&gir=yes&clen=12173660&ratebypass=yes&dur=148.282&lmt=1758298401803701&mt=1766744942&fvip=4&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=0000224&n=x4hV6yE1TgWq2g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cratebypass%2Cdur%2Clmt&sig=AJfQdSswRQIhAN-xbJ-orbFv5CXwdBA2I9S3ybpX10jdXOZtdEYxdbMwAiA0RwO_qI6ge-A_JgiN6eEqajLVZr3Onq9aGzqsXXIKQw%3D%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgMgbBB1H3Y4GkDRPaQWgksEkr09Q4gw6ynfzSt9Nop5ICIQCmIYEvNv08sPMh2cWu3085s-x3dqMgXq5w57bl8quc-w%3D%3D&pot=MlVJhTojbiKt60m7n-cz5bVCb2DzmAbDxDxBhzXNHySGg19jA1D0CBmSm9oQSuOhaaxzs1TSvcSeQFchDXbWnfJx-sOp5rgWHHTZaDm2Wj8MoM41dRTH&cver=1.20250219.01.00"... Dec 26 11:37:49 volumio volumio[1207]: info: [youtube2] VideoModel.getInfo(adsoQOm3qP4): stream validated in 0.4s. Dec 26 11:37:49 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 26 11:37:49 volumio volumio[1207]: info: [youtube2] (AutoplayManager) Enabled Dec 26 11:37:49 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 11:37:49 volumio volumio[1207]: info: sendMpdCommand stop took 1 milliseconds Dec 26 11:37:49 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand clear Dec 26 11:37:49 volumio volumio[1207]: info: sendMpdCommand clear took 0 milliseconds Dec 26 11:37:49 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hpa7zn6z.googlevideo.com/videoplayback?expire=1766767068&ei=fGVOaYfKIq2I6dsP4--GyQs&ip=37.161.238.238&id=o-ABWBl9UKYInmmyOsFtL26aL1R6OjZbdClEQhv1H6ZYA0&itag=18&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766745468%2C&mh=S6&mm=31%2C26&mn=sn-hpa7zn6z%2Csn-hgn7rn7y&ms=au%2Conr&mv=m&mvi=1&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3CCllcRpDAOCTj91bQqtTpOEVwKhHbwp0iwUOrE_Xpf-ZhKi9_ChN4XcZ7kyjbIkkIfCxn2QSbL&spc=wH4Qq-JB7HUDyLGO8dZYspiabZRvdh0cx3PRfOroAflHZTEa_QDAo2-6uetvEg&vprv=1&svpuc=1&xtags=acont%3Ddubbed%3Alang%3Dit&mime=video%2Fmp4&ns=EUCZik4uu0P7q4ycv-yhW0IR&rqh=1&gir=yes&clen=12173660&ratebypass=yes&dur=148.282&lmt=1758298401803701&mt=1766744942&fvip=4&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=0000224&n=x4hV6yE1TgWq2g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cratebypass%2Cdur%2Clmt&sig=AJfQdSswRQIhAN-xbJ-orbFv5CXwdBA2I9S3ybpX10jdXOZtdEYxdbMwAiA0RwO_qI6ge-A_JgiN6eEqajLVZr3Onq9aGzqsXXIKQw%3D%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgMgbBB1H3Y4GkDRPaQWgksEkr09Q4gw6ynfzSt9Nop5ICIQCmIYEvNv08sPMh2cWu3085s-x3dqMgXq5w57bl8quc-w%3D%3D&pot=MlVJhTojbiKt60m7n-cz5bVCb2DzmAbDxDxBhzXNHySGg19jA1D0CBmSm9oQSuOhaaxzs1TSvcSeQFchDXbWnfJx-sOp5rgWHHTZaDm2Wj8MoM41dRTH&cver=1.20250219.01.00&t.YouTube" Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: sendMpdCommand addid "https://rr1---sn-hpa7zn6z.googlevideo.com/videoplayback?expire=1766767068&ei=fGVOaYfKIq2I6dsP4--GyQs&ip=37.161.238.238&id=o-ABWBl9UKYInmmyOsFtL26aL1R6OjZbdClEQhv1H6ZYA0&itag=18&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766745468%2C&mh=S6&mm=31%2C26&mn=sn-hpa7zn6z%2Csn-hgn7rn7y&ms=au%2Conr&mv=m&mvi=1&pl=16&rms=au%2Cau&initcwndbps=1571250&bui=AYUSA3CCllcRpDAOCTj91bQqtTpOEVwKhHbwp0iwUOrE_Xpf-ZhKi9_ChN4XcZ7kyjbIkkIfCxn2QSbL&spc=wH4Qq-JB7HUDyLGO8dZYspiabZRvdh0cx3PRfOroAflHZTEa_QDAo2-6uetvEg&vprv=1&svpuc=1&xtags=acont%3Ddubbed%3Alang%3Dit&mime=video%2Fmp4&ns=EUCZik4uu0P7q4ycv-yhW0IR&rqh=1&gir=yes&clen=12173660&ratebypass=yes&dur=148.282&lmt=1758298401803701&mt=1766744942&fvip=4&fexp=51552689%2C51565115%2C51565681%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=0000224&n=x4hV6yE1TgWq2g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cratebypass%2Cdur%2Clmt&sig=AJfQdSswRQIhAN-xbJ-orbFv5CXwdBA2I9S3ybpX10jdXOZtdEYxdbMwAiA0RwO_qI6ge-A_JgiN6eEqajLVZr3Onq9aGzqsXXIKQw%3D%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgMgbBB1H3Y4GkDRPaQWgksEkr09Q4gw6ynfzSt9Nop5ICIQCmIYEvNv08sPMh2cWu3085s-x3dqMgXq5w57bl8quc-w%3D%3D&pot=MlVJhTojbiKt60m7n-cz5bVCb2DzmAbDxDxBhzXNHySGg19jA1D0CBmSm9oQSuOhaaxzs1TSvcSeQFchDXbWnfJx-sOp5rgWHHTZaDm2Wj8MoM41dRTH&cver=1.20250219.01.00&t.YouTube" took 4 milliseconds Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:37:49 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:37:49 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:37:49 volumio volumio[1207]: verbose: MPD COMMAND [object Object] Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 5ms Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 2ms Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:37:49 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 26 11:37:49 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand play Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: Dec 26 11:37:49 volumio volumio[1207]: ---------------------------- MPD announces system playlist update Dec 26 11:37:49 volumio volumio[1207]: info: Ignoring MPD Status Update Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 4ms Dec 26 11:37:49 volumio volumio[1207]: info: sendMpdCommand play took 3 milliseconds Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 3ms Dec 26 11:37:49 volumio volumio[1207]: info: ------------------------------ 2ms Dec 26 11:37:49 volumio volumio[1207]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 11:37:49 volumio volumio[1207]: InnertubeError: Playback tracking not available Dec 26 11:37:49 volumio volumio[1207]: at _VideoInfo.addToWatchHistory (/data/plugins/music_service/youtube2/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:30709:13) Dec 26 11:37:49 volumio volumio[1207]: at _VideoInfo.addToWatchHistory (/data/plugins/music_service/youtube2/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:32099:18) Dec 26 11:37:49 volumio volumio[1207]: at Object.addToHistory (/data/plugins/music_service/youtube2/dist/lib/model/VideoModel.js:66:34) Dec 26 11:37:49 volumio volumio[1207]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/youtube2/dist/lib/controller/play/PlayController.js:141:35) Dec 26 11:37:49 volumio volumio[1207]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Dec 26 11:37:49 volumio volumio[1207]: date: 2025-12-26T10:37:49.256Z, Dec 26 11:37:49 volumio volumio[1207]: version: '1.6.0', Dec 26 11:37:49 volumio volumio[1207]: info: undefined Dec 26 11:37:49 volumio volumio[1207]: } Dec 26 11:37:49 volumio volumio[1207]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 11:37:50 volumio sudo[4275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-26 11:36' Dec 26 11:37:50 volumio sudo[4275]: 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"