Feb 22 18:32:11 volumio volumio[1323]: info: [youtube2] Going to refresh session PO token in 43099 seconds Feb 22 18:32:11 volumio volumio[1323]: Upnp client error: Error: This socket has been ended by the other party Feb 22 18:32:12 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:12 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:28 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Feb 22 18:32:28 volumio volumio[1323]: 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 Feb 22 18:32:29 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:29 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:29 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:29 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:36 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Feb 22 18:32:36 volumio volumio[1323]: 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/optionSelection@genericViewUri=generic@option:o=%7B%22type%22%3A%22option%22%2C%22optionValues%22%3A%5B%7B%22text%22%3A%22Browse%22%2C%22endpoint%22%3A%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%2C%22selected%22%3Atrue%7D%2C%7B%22text%22%3A%22Live%22%2C%22endpoint%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEstorefront%22%2C%22params%22%3A%22ogUCKAg%253D%22%7D%7D%2C%22selected%22%3Afalse%7D%2C%7B%22text%22%3A%22Purchased%22%2C%22endpoint%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEstorefront%22%2C%22params%22%3A%22ogUCKAQ%253D%22%7D%7D%2C%22selected%22%3Afalse%7D%5D%7D Feb 22 18:32:36 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:37 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Feb 22 18:32:37 volumio volumio[1323]: 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%22ogUCKAg%253D%22%7D%7D Feb 22 18:32:38 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:38 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:43 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Feb 22 18:32:43 volumio volumio[1323]: 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%22ogUCKAg%253D%22%7D%7D/optionSelection@genericViewUri=generic@option:o=%7B%22type%22%3A%22option%22%2C%22optionValues%22%3A%5B%7B%22text%22%3A%22Browse%22%2C%22endpoint%22%3A%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%2C%22selected%22%3Afalse%7D%2C%7B%22text%22%3A%22Live%22%2C%22endpoint%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEstorefront%22%2C%22params%22%3A%22ogUCKAg%253D%22%7D%7D%2C%22selected%22%3Atrue%7D%2C%7B%22text%22%3A%22Purchased%22%2C%22endpoint%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEstorefront%22%2C%22params%22%3A%22ogUCKAQ%253D%22%7D%7D%2C%22selected%22%3Afalse%7D%5D%7D Feb 22 18:32:43 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:44 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Feb 22 18:32:44 volumio volumio[1323]: 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 Feb 22 18:32:45 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:45 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:45 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:32:45 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:33:02 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:33:02 volumio volumio[1323]: info: CoreCommandRouter::volumioAddQueueItems Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::addQueueItems Feb 22 18:33:02 volumio volumio[1323]: info: CorePlayQueue::addQueueItems Feb 22 18:33:02 volumio volumio[1323]: info: Preload queue cleared Feb 22 18:33:02 volumio volumio[1323]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Avatar%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Fl8aaR7VRrho%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22l8aaR7VRrho%22%7D%7D%7D Feb 22 18:33:02 volumio volumio[1323]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Avatar%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Fl8aaR7VRrho%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22l8aaR7VRrho%22%7D%7D%7D in service youtube2 Feb 22 18:33:02 volumio volumio[1323]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Avatar%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Fl8aaR7VRrho%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22l8aaR7VRrho%22%7D%7D%7D Feb 22 18:33:02 volumio volumio[1323]: info: CoreCommandRouter::volumioPushQueue Feb 22 18:33:02 volumio volumio[1323]: info: CorePlayQueue::saveQueue Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::updateTrackBlock Feb 22 18:33:02 volumio volumio[1323]: info: CorePlayQueue::getTrackBlock Feb 22 18:33:02 volumio volumio[1323]: info: CoreCommandRouter::volumioPlay Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::play index 98 Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::stop Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::stPlaybackTimer Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::updateTrackBlock Feb 22 18:33:02 volumio volumio[1323]: info: CorePlayQueue::getTrackBlock Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::pushState Feb 22 18:33:02 volumio volumio[1323]: info: CorePlayQueue::getTrack 70 Feb 22 18:33:02 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:33:02 volumio volumio[1323]: info: CoreCommandRouter::volumioPushState Feb 22 18:33:02 volumio volumio[1323]: info: CoreStateMachine::serviceStop Feb 22 18:33:02 volumio volumio[1323]: info: CorePlayQueue::getTrack 70 Feb 22 18:33:02 volumio volumio[1323]: info: CoreCommandRouter::serviceStop Feb 22 18:33:02 volumio volumio[1323]: info: ControllerMpd::stop Feb 22 18:33:02 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 18:33:02 volumio volumio[1323]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 18:33:02 volumio volumio[1323]: SPOTIFY: SPOTIFY VOLUME 59 Feb 22 18:33:02 volumio volumio[1323]: SPOTIFY: VOLUMIO VOLUME 60 Feb 22 18:33:02 volumio volumio[1323]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 18:33:02 volumio volumio[1323]: info: PeppyMeterBasic ---peppymeterbasic status stop Feb 22 18:33:03 volumio volumio[1323]: info: Feb 22 18:33:03 volumio volumio[1323]: ---------------------------- MPD announces state update: player Feb 22 18:33:03 volumio volumio[1323]: info: sendMpdCommand stop took 870 milliseconds Feb 22 18:33:03 volumio volumio[1323]: info: ControllerMpd::getState Feb 22 18:33:03 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand status Feb 22 18:33:03 volumio volumio[1323]: info: CoreStateMachine::play index undefined Feb 22 18:33:03 volumio volumio[1323]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 18:33:03 volumio volumio[1323]: info: CorePlayQueue::getTrack 98 Feb 22 18:33:03 volumio volumio[1323]: info: CoreStateMachine::startPlaybackTimer Feb 22 18:33:03 volumio volumio[1323]: info: CorePlayQueue::getTrack 98 Feb 22 18:33:03 volumio volumio[1323]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22l8aaR7VRrho%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Avatar%22%2C%22artist%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Fl8aaR7VRrho%2Fmovieposter_en.jpg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22l8aaR7VRrho%22%7D%7D%7D Feb 22 18:33:03 volumio volumio[1323]: info: sendMpdCommand status took 63 milliseconds Feb 22 18:33:03 volumio volumio[1323]: verbose: ControllerMpd::parseState Feb 22 18:33:03 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 18:33:03 volumio volumio[1323]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 18:33:03 volumio volumio[1323]: verbose: ControllerMpd::parseTrackInfo Feb 22 18:33:03 volumio volumio[1323]: info: ControllerMpd::pushState Feb 22 18:33:03 volumio volumio[1323]: info: CoreCommandRouter::servicePushState Feb 22 18:33:03 volumio volumio[1323]: info: CoreStateMachine::pushState Feb 22 18:33:03 volumio volumio[1323]: info: CorePlayQueue::getTrack 98 Feb 22 18:33:03 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 18:33:03 volumio volumio[1323]: info: CoreCommandRouter::volumioPushState Feb 22 18:33:03 volumio volumio[1323]: info: CorePlayQueue::getTrack 98 Feb 22 18:33:03 volumio volumio[1323]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Feb 22 18:33:03 volumio volumio[1323]: info: ------------------------------ 242ms Feb 22 18:33:03 volumio volumio[1323]: info: [ytmusic] Obtained PO token for video #l8aaR7VRrho: MlWKj-G9Tzzeo4qx1S2r-Z6IxtROV8aNWjTC_v4UVFaGAkSK2FpSTG2TDAyQOhFXwWIvjC0c1NwqetRnQg-H5AQtL-x7tk8UBoZib_Jlyn2x5V_xKCK7 Feb 22 18:33:03 volumio volumio[1323]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 18:33:03 volumio volumio[1323]: SPOTIFY: SPOTIFY VOLUME 59 Feb 22 18:33:03 volumio volumio[1323]: SPOTIFY: VOLUMIO VOLUME 60 Feb 22 18:33:03 volumio volumio[1323]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 18:33:03 volumio volumio[1323]: info: PeppyMeterBasic ---peppymeterbasic status stop Feb 22 18:33:04 volumio volumio[1323]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 22 18:33:04 volumio sudo[5118]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Feb 22 18:33:04 volumio sudo[5123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Feb 22 18:33:04 volumio sudo[5118]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 18:33:04 volumio sudo[5123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 18:33:04 volumio volumio[1323]: info: [ytmusic] Obtained PO token for video #l8aaR7VRrho: MlWOFyYMPosfwo4pEpzaTl_pwkyJ5rc6m1XGZjmlJeFHY0ASH-sj-6zyCJRXi2DgAAMrFOqtpWvrG9D_hb72U8VMK3S8Bz6jx-eWekdUX1R-BMvnYxxf Feb 22 18:33:05 volumio volumio[1323]: info: [youtube2] VideoModel.getInfo(l8aaR7VRrho): validating stream URL "https://rr2---sn-25glenez.googlevideo.com/videoplayback?expire=1771803184&ei=0D2babfiFc666dsP3IjZ-Qg&ip=82.67.14.206&id=o-AFrMoUA_YSmDjsxpksuhyndIlONNPK_kpPCY73SBzmaO&itag=18&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=406&met=1771781584%2C&mh=Fq&mm=31%2C26&mn=sn-25glenez%2Csn-4g5edndr&ms=au%2Conr&mv=m&mvi=2&pl=21&rms=au%2Cau&initcwndbps=2192500&bui=AVNa5-yAnQptZi2emQBeBBtePKtvfUbvbbq5HzwcN9ev7JRvLJpO64utKbaX7hFPXS7HSCPWha7cWhTX&spc=6dlaFGLby3oMaER268yMyC_iaei8HfiROWpidpeK6R-AZqsXYQEaiDZG8tbRbJnP&vprv=1&svpuc=1&xtags=acont%3Ddubbed%3Alang%3Dfr&mime=video%2Fmp4&ns=RZUVytQzxTvq9Md1EYaO3OYS&rqh=1&gir=yes&clen=6940579&ratebypass=yes&dur=93.692&lmt=1687357060145653&mt=1771781151&fvip=2&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=0000224&n=IKunSvnUoRXd1g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cratebypass%2Cdur%2Clmt&sig=AJEij0EwRAIgdO1y6gUyirjKXelkHOYC8rkHDAeuLgyVxDPWX9m0geECICG3QoNzVVjLyGA1VHAjUtwoICl-L1vrVmKOmD-ON4di&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAKZsMg40l_M84ulA-UsgX-B9mv7JXIU7RUSvKFtwV_DfAiAFql941L031gaNYGTrVTa4IWxY3vhrlSQzEN24uOkeFA%3D%3D&pot=MlWOFyYMPosfwo4pEpzaTl_pwkyJ5rc6m1XGZjmlJeFHY0ASH-sj-6zyCJRXi2DgAAMrFOqtpWvrG9D_hb72U8VMK3S8Bz6jx-eWekdUX1R-BMvnYxxf&cver=1.20250219.01.00"... Feb 22 18:33:05 volumio volumio[1323]: info: [youtube2] VideoModel.getInfo(l8aaR7VRrho): stream validated in 0.317s. Feb 22 18:33:05 volumio volumio[1323]: info: [youtube2] (AutoplayManager) Added volumioStateListener Feb 22 18:33:05 volumio volumio[1323]: info: [youtube2] (AutoplayManager) Enabled Feb 22 18:33:05 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 18:33:05 volumio volumio[1323]: info: sendMpdCommand stop took 4 milliseconds Feb 22 18:33:05 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 18:33:05 volumio volumio[1323]: info: Feb 22 18:33:05 volumio volumio[1323]: ---------------------------- MPD announces system playlist update Feb 22 18:33:05 volumio volumio[1323]: info: Ignoring MPD Status Update Feb 22 18:33:05 volumio volumio[1323]: info: sendMpdCommand clear took 4 milliseconds Feb 22 18:33:05 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-25glenez.googlevideo.com/videoplayback?expire=1771803184&ei=0D2babfiFc666dsP3IjZ-Qg&ip=82.67.14.206&id=o-AFrMoUA_YSmDjsxpksuhyndIlONNPK_kpPCY73SBzmaO&itag=18&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=406&met=1771781584%2C&mh=Fq&mm=31%2C26&mn=sn-25glenez%2Csn-4g5edndr&ms=au%2Conr&mv=m&mvi=2&pl=21&rms=au%2Cau&initcwndbps=2192500&bui=AVNa5-yAnQptZi2emQBeBBtePKtvfUbvbbq5HzwcN9ev7JRvLJpO64utKbaX7hFPXS7HSCPWha7cWhTX&spc=6dlaFGLby3oMaER268yMyC_iaei8HfiROWpidpeK6R-AZqsXYQEaiDZG8tbRbJnP&vprv=1&svpuc=1&xtags=acont%3Ddubbed%3Alang%3Dfr&mime=video%2Fmp4&ns=RZUVytQzxTvq9Md1EYaO3OYS&rqh=1&gir=yes&clen=6940579&ratebypass=yes&dur=93.692&lmt=1687357060145653&mt=1771781151&fvip=2&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=0000224&n=IKunSvnUoRXd1g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cratebypass%2Cdur%2Clmt&sig=AJEij0EwRAIgdO1y6gUyirjKXelkHOYC8rkHDAeuLgyVxDPWX9m0geECICG3QoNzVVjLyGA1VHAjUtwoICl-L1vrVmKOmD-ON4di&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAKZsMg40l_M84ulA-UsgX-B9mv7JXIU7RUSvKFtwV_DfAiAFql941L031gaNYGTrVTa4IWxY3vhrlSQzEN24uOkeFA%3D%3D&pot=MlWOFyYMPosfwo4pEpzaTl_pwkyJ5rc6m1XGZjmlJeFHY0ASH-sj-6zyCJRXi2DgAAMrFOqtpWvrG9D_hb72U8VMK3S8Bz6jx-eWekdUX1R-BMvnYxxf&cver=1.20250219.01.00&t.YouTube" Feb 22 18:33:05 volumio volumio[1323]: error: updateQueue error: null Feb 22 18:33:05 volumio volumio[1323]: info: ------------------------------ 8ms Feb 22 18:33:05 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Feb 22 18:33:05 volumio volumio[1323]: info: Feb 22 18:33:05 volumio volumio[1323]: ---------------------------- MPD announces system playlist update Feb 22 18:33:05 volumio volumio[1323]: info: Ignoring MPD Status Update Feb 22 18:33:05 volumio volumio[1323]: info: sendMpdCommand addid "https://rr2---sn-25glenez.googlevideo.com/videoplayback?expire=1771803184&ei=0D2babfiFc666dsP3IjZ-Qg&ip=82.67.14.206&id=o-AFrMoUA_YSmDjsxpksuhyndIlONNPK_kpPCY73SBzmaO&itag=18&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=406&met=1771781584%2C&mh=Fq&mm=31%2C26&mn=sn-25glenez%2Csn-4g5edndr&ms=au%2Conr&mv=m&mvi=2&pl=21&rms=au%2Cau&initcwndbps=2192500&bui=AVNa5-yAnQptZi2emQBeBBtePKtvfUbvbbq5HzwcN9ev7JRvLJpO64utKbaX7hFPXS7HSCPWha7cWhTX&spc=6dlaFGLby3oMaER268yMyC_iaei8HfiROWpidpeK6R-AZqsXYQEaiDZG8tbRbJnP&vprv=1&svpuc=1&xtags=acont%3Ddubbed%3Alang%3Dfr&mime=video%2Fmp4&ns=RZUVytQzxTvq9Md1EYaO3OYS&rqh=1&gir=yes&clen=6940579&ratebypass=yes&dur=93.692&lmt=1687357060145653&mt=1771781151&fvip=2&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=0000224&n=IKunSvnUoRXd1g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cxtags%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cratebypass%2Cdur%2Clmt&sig=AJEij0EwRAIgdO1y6gUyirjKXelkHOYC8rkHDAeuLgyVxDPWX9m0geECICG3QoNzVVjLyGA1VHAjUtwoICl-L1vrVmKOmD-ON4di&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAKZsMg40l_M84ulA-UsgX-B9mv7JXIU7RUSvKFtwV_DfAiAFql941L031gaNYGTrVTa4IWxY3vhrlSQzEN24uOkeFA%3D%3D&pot=MlWOFyYMPosfwo4pEpzaTl_pwkyJ5rc6m1XGZjmlJeFHY0ASH-sj-6zyCJRXi2DgAAMrFOqtpWvrG9D_hb72U8VMK3S8Bz6jx-eWekdUX1R-BMvnYxxf&cver=1.20250219.01.00&t.YouTube" took 339 milliseconds Feb 22 18:33:05 volumio volumio[1323]: verbose: MPD COMMAND [object Object] Feb 22 18:33:05 volumio volumio[1323]: verbose: MPD COMMAND [object Object] Feb 22 18:33:05 volumio volumio[1323]: verbose: MPD COMMAND [object Object] Feb 22 18:33:05 volumio volumio[1323]: info: ------------------------------ 15ms Feb 22 18:33:06 volumio volumio[1323]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 18:33:06 volumio volumio[1323]: verbose: ControllerMpd::sendMpdCommand play Feb 22 18:33:06 volumio volumio[1323]: info: Feb 22 18:33:06 volumio volumio[1323]: ---------------------------- MPD announces system playlist update Feb 22 18:33:06 volumio volumio[1323]: info: Ignoring MPD Status Update Feb 22 18:33:06 volumio volumio[1323]: info: sendMpdCommand play took 7 milliseconds Feb 22 18:33:06 volumio volumio[1323]: info: ------------------------------ 6ms Feb 22 18:33:06 volumio volumio[1323]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 18:33:06 volumio volumio[1323]: InnertubeError: Playback tracking not available Feb 22 18:33:06 volumio volumio[1323]: at _VideoInfo.addToWatchHistory (/data/plugins/music_service/youtube2/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:30709:13) Feb 22 18:33:06 volumio volumio[1323]: at _VideoInfo.addToWatchHistory (/data/plugins/music_service/youtube2/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:32099:18) Feb 22 18:33:06 volumio volumio[1323]: at Object.addToHistory (/data/plugins/music_service/youtube2/dist/lib/model/VideoModel.js:66:34) Feb 22 18:33:06 volumio volumio[1323]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/youtube2/dist/lib/controller/play/PlayController.js:141:35) Feb 22 18:33:06 volumio volumio[1323]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Feb 22 18:33:06 volumio volumio[1323]: date: 2026-02-22T17:33:06.031Z, Feb 22 18:33:06 volumio volumio[1323]: version: '1.6.0', Feb 22 18:33:06 volumio volumio[1323]: info: undefined Feb 22 18:33:06 volumio volumio[1323]: } Feb 22 18:33:06 volumio volumio[1323]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 18:33:07 volumio systemd[1]: peppymeterbasic.service: State 'final-sigterm' timed out. Killing. Feb 22 18:33:07 volumio systemd[1]: peppymeterbasic.service: Killing process 3525 (python3) with signal SIGKILL. Feb 22 18:33:07 volumio systemd[1]: peppymeterbasic.service: Failed with result 'timeout'. Feb 22 18:33:07 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Feb 22 18:33:07 volumio systemd[1]: peppymeterbasic.service: Consumed 6min 20.880s CPU time. Feb 22 18:33:07 volumio sudo[5118]: pam_unix(sudo:session): session closed for user root Feb 22 18:33:07 volumio sudo[5123]: pam_unix(sudo:session): session closed for user root Feb 22 18:33:09 volumio sudo[5160]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 18:32' Feb 22 18:33:09 volumio sudo[5160]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"