May 23 13:37:00 raspbmusic volumio[1053]: info: MyVolumio token set successfully May 23 13:37:00 raspbmusic volumio[1053]: info: MYVOLUMIO: Adding device May 23 13:37:00 raspbmusic volumio[1053]: info: MYVOLUMIO: Evaluating Server May 23 13:37:00 raspbmusic volumio[1053]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds) May 23 13:37:00 raspbmusic volumio[1053]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token May 23 13:37:00 raspbmusic volumio[1053]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token... May 23 13:37:02 raspbmusic volumio[1053]: info: MyVolumio status changed May 23 13:37:02 raspbmusic volumio[1053]: info: Streaming services startup May 23 13:37:02 raspbmusic volumio[1053]: info: Starting Streaming Daemon May 23 13:37:02 raspbmusic volumio[1053]: info: Removing browser output: myVolumio user plan is not superstar May 23 13:37:02 raspbmusic volumio[1053]: info: Removing audio output: May 23 13:37:02 raspbmusic volumio[1053]: info: Stoppping Tunnel 1 May 23 13:37:02 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 23 13:37:02 raspbmusic sudo[1682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 23 13:37:02 raspbmusic sudo[1682]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:37:02 raspbmusic sudo[1682]: pam_unix(sudo:session): session closed for user root May 23 13:37:02 raspbmusic sudo[1684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 23 13:37:02 raspbmusic sudo[1684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 23 13:37:02 raspbmusic sudo[1684]: pam_unix(sudo:session): session closed for user root May 23 13:37:03 raspbmusic volumio[1053]: info: Setting Geolocation for MyVolumio to eu6 May 23 13:37:03 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:03 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:03 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:03 raspbmusic volumio[1053]: info: Remote SSH Stopped May 23 13:37:03 raspbmusic volumio[1053]: error: Cannot start Volumio Streaming Daemon May 23 13:37:03 raspbmusic volumio[1053]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 23 13:37:03 raspbmusic volumio[1053]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 23 13:37:03 raspbmusic volumio[1053]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 May 23 13:37:03 raspbmusic volumio[1053]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 23 13:37:04 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:04 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:04 raspbmusic volumio[1053]: info: Updating MyVolumio device info May 23 13:37:04 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:04 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:04 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:05 raspbmusic volumio[1053]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetBrowseSources May 23 13:37:05 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 13:37:10 raspbmusic systemd[1]: systemd-timedated.service: Deactivated successfully. May 23 13:37:37 raspbmusic volumio[1053]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds May 23 13:37:37 raspbmusic volumio[1053]: info: MYVOLUMIO: Adding device May 23 13:37:37 raspbmusic volumio[1053]: info: MYVOLUMIO: Evaluating Server May 23 13:37:40 raspbmusic volumio[1053]: info: Setting Geolocation for MyVolumio to eu9 May 23 13:37:40 raspbmusic sudo[1762]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 23 13:37:40 raspbmusic sudo[1762]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:37:40 raspbmusic sudo[1764]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 23 13:37:40 raspbmusic sudo[1764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:37:40 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:40 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:40 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:40 raspbmusic sudo[1762]: pam_unix(sudo:session): session closed for user root May 23 13:37:40 raspbmusic sudo[1764]: pam_unix(sudo:session): session closed for user root May 23 13:37:41 raspbmusic volumio[1053]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 23 13:37:41 raspbmusic volumio[1053]: verbose: New Socket.io Connection to 192.168.32.114 from 192.168.33.178 UA: Mozilla/5.0 (X11; Linux x86_64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 4 May 23 13:37:41 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:41 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:41 raspbmusic volumio[1053]: info: Updating MyVolumio device info May 23 13:37:41 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:41 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:41 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 13:37:41 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetQueue May 23 13:37:41 raspbmusic volumio[1053]: info: CoreStateMachine::getQueue May 23 13:37:41 raspbmusic volumio[1053]: info: CorePlayQueue::getQueue May 23 13:37:42 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid May 23 13:37:42 raspbmusic volumio[1053]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] May 23 13:37:42 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction May 23 13:37:42 raspbmusic volumio[1053]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs May 23 13:37:42 raspbmusic volumio[1053]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] May 23 13:37:42 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection May 23 13:37:44 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:44 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop May 23 13:37:45 raspbmusic volumio[1053]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 23 13:37:45 raspbmusic volumio[1053]: info: sendMpdCommand stop took 860 milliseconds May 23 13:37:45 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear May 23 13:37:45 raspbmusic volumio[1053]: info: May 23 13:37:45 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:45 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:45 raspbmusic volumio[1053]: info: sendMpdCommand clear took 138 milliseconds May 23 13:37:45 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube" May 23 13:37:45 raspbmusic volumio[1053]: info: May 23 13:37:45 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:45 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:45 raspbmusic volumio[1053]: info: May 23 13:37:45 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:45 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:45 raspbmusic volumio[1053]: error: updateQueue error: null May 23 13:37:45 raspbmusic volumio[1053]: info: May 23 13:37:45 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:45 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:45 raspbmusic volumio[1053]: info: ------------------------------ 128ms May 23 13:37:45 raspbmusic volumio[1053]: info: sendMpdCommand addid "https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube" took 110 milliseconds May 23 13:37:45 raspbmusic volumio[1053]: info: ------------------------------ 97ms May 23 13:37:45 raspbmusic volumio[1053]: info: ------------------------------ 94ms May 23 13:37:45 raspbmusic volumio[1053]: verbose: MPD COMMAND [object Object] May 23 13:37:45 raspbmusic volumio[1053]: verbose: MPD COMMAND [object Object] May 23 13:37:45 raspbmusic volumio[1053]: verbose: MPD COMMAND [object Object] May 23 13:37:45 raspbmusic volumio[1053]: info: May 23 13:37:45 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:45 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:45 raspbmusic volumio[1053]: info: May 23 13:37:45 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:45 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:46 raspbmusic volumio[1053]: info: May 23 13:37:46 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:46 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:46 raspbmusic volumio[1053]: info: ------------------------------ 275ms May 23 13:37:46 raspbmusic volumio[1053]: info: ------------------------------ 184ms May 23 13:37:46 raspbmusic volumio[1053]: info: ------------------------------ 168ms May 23 13:37:46 raspbmusic volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd May 23 13:37:46 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand play May 23 13:37:46 raspbmusic volumio[1053]: info: May 23 13:37:46 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:46 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:46 raspbmusic volumio[1053]: info: May 23 13:37:46 raspbmusic volumio[1053]: ---------------------------- MPD announces system playlist update May 23 13:37:46 raspbmusic volumio[1053]: info: Ignoring MPD Status Update May 23 13:37:46 raspbmusic volumio[1053]: info: ------------------------------ 764ms May 23 13:37:46 raspbmusic volumio[1053]: info: sendMpdCommand play took 743 milliseconds May 23 13:37:46 raspbmusic volumio[1053]: info: ------------------------------ 743ms May 23 13:37:46 raspbmusic volumio[1053]: info: ------------------------------ 732ms May 23 13:37:48 raspbmusic volumio[1053]: info: May 23 13:37:48 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:48 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:48 raspbmusic volumio[1053]: info: May 23 13:37:48 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:48 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:48 raspbmusic volumio[1053]: info: May 23 13:37:48 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:48 raspbmusic volumio[1053]: info: May 23 13:37:48 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:48 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand status took 100 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:48 raspbmusic volumio[1053]: info: May 23 13:37:48 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:48 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:48 raspbmusic volumio[1053]: info: May 23 13:37:48 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:48 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand status took 226 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand status took 140 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand status took 135 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 110 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand status took 71 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: info: sendMpdCommand status took 41 milliseconds May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:48 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:49 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:49 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:49 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:49 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService play May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus stop May 23 13:37:49 raspbmusic volumio[1053]: info: ------------------------------ 411ms May 23 13:37:49 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 309 milliseconds May 23 13:37:49 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 309 milliseconds May 23 13:37:49 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 309 milliseconds May 23 13:37:49 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 267 milliseconds May 23 13:37:49 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 249 milliseconds May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:49 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:49 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:49 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:49 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:49 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService play May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus play May 23 13:37:49 raspbmusic volumio[1053]: info: Received an update from plugin. extracting info from payload May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:49 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:49 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:49 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService play May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus play May 23 13:37:49 raspbmusic volumio[1053]: info: Received an update from plugin. extracting info from payload May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:49 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:49 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:49 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService play May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus play May 23 13:37:49 raspbmusic volumio[1053]: info: Received an update from plugin. extracting info from payload May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:49 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:49 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:49 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService play May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus play May 23 13:37:49 raspbmusic volumio[1053]: info: Received an update from plugin. extracting info from payload May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:49 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:49 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:49 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService play May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus play May 23 13:37:49 raspbmusic volumio[1053]: info: Received an update from plugin. extracting info from payload May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:49 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:50 raspbmusic volumio[1053]: info: ------------------------------ 1411ms May 23 13:37:50 raspbmusic volumio[1053]: info: ------------------------------ 1410ms May 23 13:37:50 raspbmusic volumio[1053]: info: ------------------------------ 1402ms May 23 13:37:50 raspbmusic volumio[1053]: info: ------------------------------ 1320ms May 23 13:37:50 raspbmusic volumio[1053]: info: ------------------------------ 1304ms May 23 13:37:50 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:50 raspbmusic volumio[1053]: verbose: New Socket.io Connection to 192.168.32.114 from 192.168.33.178 UA: Mozilla/5.0 (X11; Linux x86_64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 4 May 23 13:37:51 raspbmusic volumio[1053]: verbose: New Socket.io Connection to 192.168.32.114 from 192.168.33.178 UA: Mozilla/5.0 (X11; Linux x86_64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 5 May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: Received Get System Info May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 13:37:51 raspbmusic volumio[1053]: info: Discovery: Getting this device information May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetVisibleSources May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 23 13:37:51 raspbmusic volumio[1053]: info: Received Get System Info May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 13:37:51 raspbmusic volumio[1053]: info: Discovery: Getting this device information May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: Listing playlists May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 23 13:37:51 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 23 13:37:52 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 23 13:37:52 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 23 13:37:52 raspbmusic volumio[1053]: info: Received Get System Info May 23 13:37:52 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 13:37:52 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 13:37:52 raspbmusic volumio[1053]: info: Discovery: Getting this device information May 23 13:37:52 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:52 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 13:37:53 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 23 13:37:53 raspbmusic volumio[1053]: info: Received Get System Info May 23 13:37:53 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 13:37:53 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 13:37:53 raspbmusic volumio[1053]: info: Discovery: Getting this device information May 23 13:37:53 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:37:53 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 13:37:53 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::stPlaybackTimer May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::servicePause May 23 13:37:54 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::pause May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand pause May 23 13:37:54 raspbmusic volumio[1053]: info: May 23 13:37:54 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand pause took 28 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:54 raspbmusic volumio[1053]: info: May 23 13:37:54 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:54 raspbmusic volumio[1053]: info: May 23 13:37:54 raspbmusic volumio[1053]: ---------------------------- MPD announces state update: player May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::getState May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand status May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand status took 67 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand status took 35 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand status took 18 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::parseState May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 30 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 30 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: info: sendMpdCommand playlistinfo took 29 milliseconds May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:54 raspbmusic volumio[1053]: verbose: ControllerMpd::parseTrackInfo May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:54 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:54 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6740,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:54 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::stPlaybackTimer May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:54 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:54 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6740,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:54 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::stPlaybackTimer May 23 13:37:54 raspbmusic volumio[1053]: info: ControllerMpd::pushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::servicePushState May 23 13:37:54 raspbmusic volumio[1053]: info: CorePlayQueue::getTrack 0 May 23 13:37:54 raspbmusic volumio[1053]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6740,"duration":297,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Charli xcx - party 4 u (official video)","artist":"Charli xcx","album":"YouTube","uri":"https://rr1---sn-8va103g-3c2e.googlevideo.com/videoplayback?expire=1748018258&ei=8k8waMyGFp2Z6dsP5uuloQY&ip=91.195.214.232&id=o-ALKzbuEFU5C1MbJkozZVoOremCDr6qZLFHmW2amJzzoS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1747996658%2C&mh=pd&mm=31%2C29&mn=sn-8va103g-3c2e%2Csn-3c27sn7r&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=ua&initcwndbps=8172500&bui=AecWEAYad41VXRz6--NOKsYtjBbGVBP6l0aaLHZPkPZlLOQfscjC9rhC1Vh4ZA1i7TfD4DsYgkq7P_lX&spc=wk1kZgzoh0KeOb5Dj2O79XaRAU79oVUkys0LFr4VzGCPNkcA7bRJcKB3-YgX7zDEqxM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=F77Fd16cQefo396DoeYD3t4Q&rqh=1&gir=yes&clen=5207809&dur=296.701&lmt=1747352816484489&mt=1747996156&fvip=17&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=3308224&n=f_EDTwRqPpCC1Q&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%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRQIhANvRogFuLdBoJe4kyTfFVgwMrH4-BgLuyBxTNkQE57g_AiBOSKc7Wm0Yt-feq3MgraCX1axr3z3sOML9NZTaov9pxw%3D%3D&sig=AJfQdSswRQIhAM1oj3XjaWLmbEPKwWgt8NC0fBSpHsOJN-h4Jj6iqnn8AiAGXzHZZjdz0qcl7I-xDLEHv5mCIYmBkynBDdTxNK4olw%3D%3D&pot=MnjP27BBfO28nc_n1rOLSfRUs2yMBAFNUXZmjBM_Njt3wtqVWgodB2OLj6QlHA8QbP36-8NSXbjk3ZTvrWNhZjjqcKuepndM-8VLMKaON3oXlNgam_p7JkIPhvZBr5AAC9GF59uOsiQHu3qukgOrEIZspSYPsAAV--o%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 23 13:37:54 raspbmusic volumio[1053]: verbose: CURRENT POSITION 0 May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::syncState stateService pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::syncState currentStatus pause May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::pushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioPushState May 23 13:37:54 raspbmusic volumio[1053]: info: CoreStateMachine::stPlaybackTimer May 23 13:37:54 raspbmusic volumio[1053]: info: ------------------------------ 411ms May 23 13:37:54 raspbmusic volumio[1053]: info: ------------------------------ 379ms May 23 13:37:54 raspbmusic volumio[1053]: info: ------------------------------ 376ms May 23 13:37:56 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 23 13:37:56 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 23 13:38:00 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 23 13:38:00 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 23 13:38:01 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 23 13:38:08 raspbmusic volumio[1053]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 23 13:38:08 raspbmusic volumio[1053]: info: Received Get System Version May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 13:38:08 raspbmusic volumio[1053]: info: Received Get System Info May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 13:38:08 raspbmusic volumio[1053]: info: Discovery: Getting this device information May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:38:08 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 13:38:23 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetState May 23 13:38:24 raspbmusic volumio[1053]: info: CoreCommandRouter::volumioGetQueue May 23 13:38:24 raspbmusic volumio[1053]: info: CoreStateMachine::getQueue May 23 13:38:24 raspbmusic volumio[1053]: info: CorePlayQueue::getQueue May 23 13:38:27 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 23 13:38:27 raspbmusic volumio[1053]: info: Preload queue cleared May 23 13:38:31 raspbmusic volumio[1053]: Searching plugin music_service/webradio May 23 13:38:31 raspbmusic volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 23 13:38:32 raspbmusic volumio[1053]: Use XMLElement.setAttribute instead May 23 13:38:32 raspbmusic volumio[1053]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 13:38:32 raspbmusic volumio[1053]: TypeError: children[i].attr(...).value is not a function May 23 13:38:32 raspbmusic volumio[1053]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 May 23 13:38:32 raspbmusic volumio[1053]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) May 23 13:38:32 raspbmusic volumio[1053]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 13:38:38 raspbmusic sudo[1878]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-23 13:37' May 23 13:38:38 raspbmusic sudo[1878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:38:38 raspbmusic systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 23 13:38:38 raspbmusic dbus-daemon[587]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.24' (uid=0 pid=1881 comm="timedatectl show --property=NTPSynchronized --valu") May 23 13:38:38 raspbmusic systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 23 13:38:38 raspbmusic dbus-daemon[587]: [system] Successfully activated service 'org.freedesktop.timedate1' May 23 13:38:38 raspbmusic systemd[1]: Started systemd-timedated.service - Time & Date Service. May 23 13:38:38 raspbmusic setdatetime-helper.sh[1880]: Time is not synchronized. Attempting to sync... 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="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"