May 22 09:47:17 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 09:47:17 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 22 09:47:17 volumio dbus-daemon[644]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.25' (uid=0 pid=2358 comm="timedatectl show --property=NTPSynchronized --valu") May 22 09:47:17 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 22 09:47:18 volumio dbus-daemon[644]: [system] Successfully activated service 'org.freedesktop.timedate1' May 22 09:47:18 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 22 09:47:18 volumio setdatetime-helper.sh[2357]: Time is not synchronized. Attempting to sync... May 22 09:47:18 volumio sudo[2368]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 22 May 2025 13:47:18 GMT#015' May 22 09:47:18 volumio sudo[2368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 22 09:47:18 volumio setdatetime-helper.sh[2369]: Thu May 22 09:47:18 EDT 2025 May 22 09:47:18 volumio systemd-journald[355]: Time jumped backwards, rotating. May 22 09:47:18 volumio setdatetime-helper.sh[2357]: Time synchronized successfully. May 22 09:47:18 volumio sudo[2368]: pam_unix(sudo:session): session closed for user root May 22 09:47:18 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 22 09:47:18 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 22 09:47:31 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: ytmusic , explodeUri May 22 09:47:31 volumio volumio[1003]: info: [ytmusic-browse] explodeUri: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Rolling%20Away%22%2C%22artist%22%3A%22Beta%20Radio%22%2C%22album%22%3A%22Waiting%20for%20the%20End%20to%20Come%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FlsUrK7aEVu6TvEMwYVMK6LxwIFfWxUP7CyVCasdrXyU14vOaIOW2SzNubZEtg1IKO_Cmiwold58DVksz%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%228eniefYb_w8%22%2C%22playlistId%22%3A%22RDAO84YriFBz0BHe_dbXBeZxCA%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDAO84YriFBz0BHe_dbXBeZxCA%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22Ac_D8_Msr84%22%7D%7D%7D%7D May 22 09:47:31 volumio volumio[1003]: info: Saving local item beta radio May 22 09:47:31 volumio volumio[1003]: info: Pushing Favourites {"uri":"ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Rolling%20Away%22%2C%22artist%22%3A%22Beta%20Radio%22%2C%22album%22%3A%22Waiting%20for%20the%20End%20to%20Come%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FlsUrK7aEVu6TvEMwYVMK6LxwIFfWxUP7CyVCasdrXyU14vOaIOW2SzNubZEtg1IKO_Cmiwold58DVksz%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%228eniefYb_w8%22%2C%22playlistId%22%3A%22RDAO84YriFBz0BHe_dbXBeZxCA%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDAO84YriFBz0BHe_dbXBeZxCA%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22Ac_D8_Msr84%22%7D%7D%7D%7D","favourite":false} May 22 09:47:31 volumio volumio[1003]: info: Listing playlists May 22 09:47:43 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 09:47:43 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 22 09:47:47 volumio volumio[1003]: info: [1747921667663] ControllerPandora::flushPandora May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getQueue May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::clearAddPlayQueue May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::saveQueue May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::serviceClearAddPlayTracks May 22 09:47:47 volumio volumio[1003]: error: WARNING: No clearAddPlayTracks method for service ytmusic May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushQueue May 22 09:47:47 volumio volumio[1003]: info: [1747921667677] ControllerPandora::stop May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::stop May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand stop May 22 09:47:47 volumio volumio[1003]: info: sendMpdCommand stop took 14 milliseconds May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::clear May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand clear May 22 09:47:47 volumio volumio[1003]: info: May 22 09:47:47 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:47 volumio volumio[1003]: info: May 22 09:47:47 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:47 volumio volumio[1003]: info: May 22 09:47:47 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:47 volumio volumio[1003]: info: May 22 09:47:47 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:47 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:47 volumio volumio[1003]: info: sendMpdCommand clear took 8 milliseconds May 22 09:47:47 volumio volumio[1003]: info: sendMpdCommand status took 6 milliseconds May 22 09:47:47 volumio volumio[1003]: info: sendMpdCommand status took 5 milliseconds May 22 09:47:47 volumio volumio[1003]: info: sendMpdCommand status took 3 milliseconds May 22 09:47:47 volumio volumio[1003]: info: [1747921667704] ControllerPandora::pushState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 09:47:47 volumio volumio[1003]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received pandora May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService mpd May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:47 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesPandora Radio May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 09:47:47 volumio volumio[1003]: Cannot find translation for source YouTube2 May 22 09:47:47 volumio volumio[1003]: Cannot find translation for source YouTube Music May 22 09:47:47 volumio volumio[1003]: Cannot find translation for source Radio Paradise May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 09:47:47 volumio volumio[1003]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 09:47:47 volumio volumio[1003]: verbose: CURRENT POSITION 0 May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::syncState stateService stop May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus play May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::play index undefined May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd May 22 09:47:47 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd May 22 09:47:47 volumio volumio[1003]: info: Disabling plugin pandora May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::startPlaybackTimer May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Sitting%20Room%22%2C%22artist%22%3A%22Beta%20Radio%22%2C%22album%22%3A%22Colony%20of%20Bees%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2F3UZGiDQxelRXFizPVZ13qr4WcXZ_5GHiQHX7Ma3mu2G6JW41l572xkMNgGqOxE88x2d1_TPlArYYato_xA%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22fuaNHx8JL8c%22%2C%22playlistId%22%3A%22RDAO84YriFBz0BHe_dbXBeZxCA%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A1%2C%22playlistSetVideoId%22%3A%22289F4A46DF0A30D2%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDAO84YriFBz0BHe_dbXBeZxCA%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22Ac_D8_Msr84%22%7D%7D%7D%7D May 22 09:47:47 volumio volumio[1003]: info: ------------------------------ 42ms May 22 09:47:47 volumio volumio[1003]: info: ------------------------------ 41ms May 22 09:47:47 volumio volumio[1003]: info: ------------------------------ 39ms May 22 09:47:47 volumio volumio[1003]: info: Done. May 22 09:47:47 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 09:47:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:47 volumio volumio[1003]: info: May 22 09:47:47 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:47 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:47 volumio volumio[1003]: info: May 22 09:47:47 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:47 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:47 volumio volumio[1003]: error: updateQueue error: null May 22 09:47:47 volumio volumio[1003]: error: updateQueue error: null May 22 09:47:47 volumio volumio[1003]: error: updateQueue error: null May 22 09:47:47 volumio volumio[1003]: info: ------------------------------ 65ms May 22 09:47:47 volumio volumio[1003]: info: ------------------------------ 6ms May 22 09:47:47 volumio volumio[1003]: info: ------------------------------ 5ms May 22 09:47:47 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. May 22 09:47:48 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:48 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand stop May 22 09:47:48 volumio volumio[1003]: info: sendMpdCommand stop took 0 milliseconds May 22 09:47:48 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand clear May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: sendMpdCommand clear took 1 milliseconds May 22 09:47:48 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube" May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: error: updateQueue error: null May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 4ms May 22 09:47:48 volumio volumio[1003]: info: sendMpdCommand addid "https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 4ms May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 3ms May 22 09:47:48 volumio volumio[1003]: verbose: MPD COMMAND [object Object] May 22 09:47:48 volumio volumio[1003]: verbose: MPD COMMAND [object Object] May 22 09:47:48 volumio volumio[1003]: verbose: MPD COMMAND [object Object] May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 5ms May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 3ms May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 2ms May 22 09:47:48 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService mpd May 22 09:47:48 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand play May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: May 22 09:47:48 volumio volumio[1003]: ---------------------------- MPD announces system playlist update May 22 09:47:48 volumio volumio[1003]: info: Ignoring MPD Status Update May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 5ms May 22 09:47:48 volumio volumio[1003]: info: sendMpdCommand play took 4 milliseconds May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 3ms May 22 09:47:48 volumio volumio[1003]: info: ------------------------------ 2ms May 22 09:47:49 volumio volumio[1003]: info: May 22 09:47:49 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:49 volumio volumio[1003]: info: May 22 09:47:49 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:49 volumio volumio[1003]: info: May 22 09:47:49 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:49 volumio volumio[1003]: info: May 22 09:47:49 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand status took 7 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand status took 6 milliseconds May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 09:47:49 volumio volumio[1003]: info: May 22 09:47:49 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:49 volumio volumio[1003]: info: May 22 09:47:49 volumio volumio[1003]: ---------------------------- MPD announces state update: player May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::getState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand status May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand status took 9 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand status took 4 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand playlistinfo took 4 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand playlistinfo took 4 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand status took 3 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand status took 3 milliseconds May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseTrackInfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseTrackInfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseState May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:49 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:49 volumio volumio[1003]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sitting Room","artist":"Beta Radio","album":"Colony of Bees","uri":"https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 22 09:47:49 volumio volumio[1003]: verbose: CURRENT POSITION 1 May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState stateService play May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus stop May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:49 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:49 volumio volumio[1003]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sitting Room","artist":"Beta Radio","album":"Colony of Bees","uri":"https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 22 09:47:49 volumio volumio[1003]: verbose: CURRENT POSITION 1 May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState stateService play May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus play May 22 09:47:49 volumio volumio[1003]: info: Received an update from plugin. extracting info from payload May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: ------------------------------ 25ms May 22 09:47:49 volumio volumio[1003]: info: ------------------------------ 31ms May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand playlistinfo took 19 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand playlistinfo took 19 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand playlistinfo took 17 milliseconds May 22 09:47:49 volumio volumio[1003]: info: sendMpdCommand playlistinfo took 17 milliseconds May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseTrackInfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseTrackInfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseTrackInfo May 22 09:47:49 volumio volumio[1003]: verbose: ControllerMpd::parseTrackInfo May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:49 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:49 volumio volumio[1003]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sitting Room","artist":"Beta Radio","album":"Colony of Bees","uri":"https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 22 09:47:49 volumio volumio[1003]: verbose: CURRENT POSITION 1 May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState stateService play May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus play May 22 09:47:49 volumio volumio[1003]: info: Received an update from plugin. extracting info from payload May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:49 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:49 volumio volumio[1003]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sitting Room","artist":"Beta Radio","album":"Colony of Bees","uri":"https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 22 09:47:49 volumio volumio[1003]: verbose: CURRENT POSITION 1 May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState stateService play May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus play May 22 09:47:49 volumio volumio[1003]: info: Received an update from plugin. extracting info from payload May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:49 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:49 volumio volumio[1003]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sitting Room","artist":"Beta Radio","album":"Colony of Bees","uri":"https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 22 09:47:49 volumio volumio[1003]: verbose: CURRENT POSITION 1 May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState stateService play May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus play May 22 09:47:49 volumio volumio[1003]: info: Received an update from plugin. extracting info from payload May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: ControllerMpd::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 09:47:49 volumio volumio[1003]: info: CorePlayQueue::getTrack 1 May 22 09:47:49 volumio volumio[1003]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sitting Room","artist":"Beta Radio","album":"Colony of Bees","uri":"https://rr3---sn-8xgp1vo-ab5l.googlevideo.com/videoplayback?expire=1747943267&ei=AysvaJ7kNq68kucPn_nwgAo&ip=141.155.13.162&id=o-AJEP88AcmL65Pa8Lx0jvjrGzPgPTPlkGw_TqoMmn_cnc&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747921667%2C&mh=GK&mm=31%2C26&mn=sn-8xgp1vo-ab5l%2Csn-p5qlsndz&ms=au%2Conr&mv=m&mvi=3&pl=18&rms=au%2Cau&gcr=us&initcwndbps=4005000&bui=AecWEAawr3E3Rx2wz-w5nWUEutgP5brcyCzl3roGMH-1ARcHcqUsijTIUl6-6Wwwn6hje3hlRhTJ1rId&spc=wk1kZqHPJuxDsUtMhBWWvQ8tGrdmDVZqxN6MLU2xhizzGQbQZ4PkQkFdVSRGid96kQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1q0GGaaNSYFqA391CznNLcoQ&rqh=1&gir=yes&clen=4354629&dur=249.081&lmt=1714760708231139&mt=1747921310&fvip=1&keepalive=yes&fexp=51466643%2C51476174&c=WEB_REMIX&sefc=1&txp=1432434&n=CHWc7kpvNpOO6A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIgGML5nuPiD2Xbkp8QMwi_ul6N7uLBG_0FHHFe81XiWkgCIQDGgUR-x-38NOqifD0SqB5oYwzL_B82WyS7YBXmf4PEnA%3D%3D&sig=AJfQdSswRQIgRy92xnOCI1GkF7A9hcGJaO_v4C1laQNljJbpmM1Ml4QCIQDr67uHmIAWVJ4JRrb_APif1QY93YjkGc7an3vXlZxqLw%3D%3D&pot=MnhVb7EhIoc0cFVTeYDSTVbNuCceSHol5VqWZBPQUukVEv5pMyAyVQOosgYhQ-zMDMEyPeZkn3KoT3fNlFKnb-AZM0saOPUFw4kenukdRvhpIejbUSD0fwRGokzWwE9QVSDxLUpW1RZXOtI23mrxoOGMOlZofpw9E2k%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 22 09:47:49 volumio volumio[1003]: verbose: CURRENT POSITION 1 May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState stateService play May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus play May 22 09:47:49 volumio volumio[1003]: info: Received an update from plugin. extracting info from payload May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: CoreStateMachine::pushState May 22 09:47:49 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 09:47:49 volumio volumio[1003]: info: ------------------------------ 64ms May 22 09:47:49 volumio volumio[1003]: info: ------------------------------ 61ms May 22 09:47:49 volumio volumio[1003]: info: ------------------------------ 58ms May 22 09:47:49 volumio volumio[1003]: info: ------------------------------ 58ms May 22 09:48:03 volumio volumio[1003]: info: Enabling plugin pandora May 22 09:48:03 volumio volumio[1003]: info: Loading plugin "pandora"... May 22 09:48:03 volumio volumio[1003]: info: Applying required configuration parameters for plugin pandora May 22 09:48:03 volumio volumio[1003]: info: PLUGIN START: pandora May 22 09:48:03 volumio volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 22 09:48:03 volumio volumio[1003]: info: [1747921683263] CoreMusicLibrary::Adding element Pandora Radio May 22 09:48:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 09:48:03 volumio volumio[1003]: Cannot find translation for source YouTube2 May 22 09:48:03 volumio volumio[1003]: Cannot find translation for source YouTube Music May 22 09:48:03 volumio volumio[1003]: Cannot find translation for source Radio Paradise May 22 09:48:03 volumio volumio[1003]: Cannot find translation for source Pandora Radio May 22 09:48:03 volumio volumio[1003]: info: [1747921683267] ControllerPandora::initializeMQTT May 22 09:48:03 volumio volumio[1003]: info: [1747921683268] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration May 22 09:48:03 volumio volumio[1003]: info: [1747921683268] ControllerPandora::initialSetup May 22 09:48:03 volumio volumio[1003]: info: [1747921683270] ControllerPandora::PandoraHandler::init May 22 09:48:03 volumio volumio[1003]: info: [1747921683270] ControllerPandora::PandoraHandler::loadErrorCodes May 22 09:48:03 volumio volumio[1003]: info: [1747921683271] [Pandora] PandoraHandler::setMaxStationTracks: 16 May 22 09:48:03 volumio volumio[1003]: info: [1747921683271] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty May 22 09:48:03 volumio volumio[1003]: info: [1747921683272] ControllerPandora::flushPandora May 22 09:48:03 volumio volumio[1003]: info: CorePlayQueue::getQueue May 22 09:48:03 volumio volumio[1003]: info: CorePlayQueue::clearAddPlayQueue May 22 09:48:03 volumio volumio[1003]: info: CorePlayQueue::saveQueue May 22 09:48:03 volumio volumio[1003]: info: CoreCommandRouter::serviceClearAddPlayTracks May 22 09:48:03 volumio volumio[1003]: error: WARNING: No clearAddPlayTracks method for service ytmusic May 22 09:48:03 volumio volumio[1003]: info: CoreCommandRouter::volumioPushQueue May 22 09:48:03 volumio volumio[1003]: info: [1747921683282] ControllerPandora::validateAndSetAccountOptions May 22 09:48:03 volumio volumio[1003]: error: [1747921683282] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. May 22 09:48:03 volumio volumio[1003]: info: Done. May 22 09:48:04 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 09:48:28 volumio volumio[1003]: info: CALLMETHOD: music_service pandora setAccountOptionsConf [object Object] May 22 09:48:28 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: pandora , setAccountOptionsConf May 22 09:48:28 volumio volumio[1003]: info: [1747921708274] ControllerPandora::validateAndSetAccountOptions May 22 09:48:28 volumio volumio[1003]: info: [1747921708274] ControllerPandora::PandoraHandler::setAccountOptions May 22 09:48:28 volumio volumio[1003]: info: [1747921708276] ControllerPandora::flushPandora May 22 09:48:28 volumio volumio[1003]: info: CorePlayQueue::getQueue May 22 09:48:28 volumio volumio[1003]: info: CorePlayQueue::clearAddPlayQueue May 22 09:48:28 volumio volumio[1003]: info: CorePlayQueue::saveQueue May 22 09:48:28 volumio volumio[1003]: info: CoreCommandRouter::serviceClearAddPlayTracks May 22 09:48:28 volumio volumio[1003]: error: WARNING: No clearAddPlayTracks method for service ytmusic May 22 09:48:28 volumio volumio[1003]: info: CoreCommandRouter::volumioPushQueue May 22 09:48:28 volumio volumio[1003]: info: [1747921708286] [Pandora] PreventAuthTimeout::init: Timer loaded May 22 09:48:28 volumio volumio[1003]: info: [1747921708286] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms May 22 09:48:28 volumio volumio[1003]: info: [1747921708286] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval May 22 09:48:28 volumio volumio[1003]: info: [1747921708286] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations May 22 09:48:28 volumio volumio[1003]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 09:48:28 volumio volumio[1003]: Error: error:0308010C:digital envelope routines::unsupported May 22 09:48:28 volumio volumio[1003]: at Decipheriv.createCipherBase (node:internal/crypto/cipher:121:19) May 22 09:48:28 volumio volumio[1003]: at Decipheriv.createCipherWithIV (node:internal/crypto/cipher:140:3) May 22 09:48:28 volumio volumio[1003]: at new Decipheriv (node:internal/crypto/cipher:289:3) May 22 09:48:28 volumio volumio[1003]: at Object.createDecipheriv (node:crypto:154:10) May 22 09:48:28 volumio volumio[1003]: at /data/plugins/music_service/pandora/node_modules/anesidora/encryption.js:30:29 May 22 09:48:28 volumio volumio[1003]: at exports.decrypt (/data/plugins/music_service/pandora/node_modules/anesidora/encryption.js:45:16) May 22 09:48:28 volumio volumio[1003]: at decryptSyncTime (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:54:36) May 22 09:48:28 volumio volumio[1003]: at /data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:72:37 May 22 09:48:28 volumio volumio[1003]: at Request._callback (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:46:24) May 22 09:48:28 volumio volumio[1003]: at self.callback (/data/plugins/music_service/pandora/node_modules/request/request.js:185:22) May 22 09:48:28 volumio volumio[1003]: at Request.emit (node:events:514:28) May 22 09:48:28 volumio volumio[1003]: at Request. (/data/plugins/music_service/pandora/node_modules/request/request.js:1154:10) May 22 09:48:28 volumio volumio[1003]: at Request.emit (node:events:514:28) May 22 09:48:28 volumio volumio[1003]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:1076:12) May 22 09:48:28 volumio volumio[1003]: at Object.onceWrapper (node:events:628:28) May 22 09:48:28 volumio volumio[1003]: at IncomingMessage.emit (node:events:526:35) { May 22 09:48:28 volumio volumio[1003]: library: 'digital envelope routines', May 22 09:48:28 volumio volumio[1003]: reason: 'unsupported', May 22 09:48:28 volumio volumio[1003]: code: 'ERR_OSSL_EVP_UNSUPPORTED' May 22 09:48:28 volumio volumio[1003]: } May 22 09:48:28 volumio volumio[1003]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 09:48:28 volumio sudo[2637]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-22 09:47' May 22 09:48:28 volumio sudo[2637]: 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="26d819930af572ef184e636a18ef1127de78f391" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 21 13:47:54 UTC 2025" VOLUMIO_VERSION="0.068" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="82c7b61aa1619bd495d6c4f648975de8"