May 23 13:46:02 work-volumio volumio[1129]: info: CoreCommandRouter::Close All Modals sent May 23 13:46:12 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 23 13:46:12 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 23 13:46:13 work-volumio volumio[1129]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 23 13:46:13 work-volumio volumio[1129]: info: Received Get System Version May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 13:46:13 work-volumio volumio[1129]: info: Received Get System Info May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 13:46:13 work-volumio volumio[1129]: info: Discovery: Getting this device information May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::volumioGetState May 23 13:46:13 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 12 May 23 13:46:13 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 13:46:19 work-volumio volumio[1129]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/now_playing/volumio/bookworm/armhf May 23 13:46:24 work-volumio volumio[1129]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/now_playing/volumio/bookworm/armhf May 23 13:46:24 work-volumio volumio[1129]: warn: [now-playing] MyBackgroundMonitor stopped May 23 13:46:26 work-volumio volumio[1129]: info: Check plugin dependencies May 23 13:46:28 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 13:46:28 work-volumio volumio[1129]: info: Rename folder May 23 13:46:28 work-volumio volumio[1129]: info: Folder /tmp/downloaded_plugin.zip removed May 23 13:46:28 work-volumio volumio[1129]: Upnp client error: Error: This socket has been ended by the other party May 23 13:46:28 work-volumio volumio[1129]: info: Move to category May 23 13:46:29 work-volumio volumio[1129]: error: Error moving plugin folder: Error: Command failed: /bin/mv /data/plugins/now_playing /data/plugins/user_interface May 23 13:46:29 work-volumio volumio[1129]: /bin/mv: cannot move '/data/plugins/now_playing' to '/data/plugins/user_interface/now_playing': Directory not empty May 23 13:46:29 work-volumio volumio[1129]: info: An error occurred installing the plugin. Rolling back config May 23 13:46:29 work-volumio volumio[1129]: info: Plugin folders cleanup May 23 13:46:29 work-volumio volumio[1129]: info: Scanning into folder /volumio/app/plugins/ May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category audio_interface May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category miscellanea May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category music_service May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category plugins.json May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category system_controller May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category user_interface May 23 13:46:29 work-volumio volumio[1129]: info: Scanning into folder /data/plugins/ May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category music_service May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category now_playing May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/README.md May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/config.json May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/eslint.config.mjs May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/fixup.sh May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/gitignore May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/install.sh May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/package-lock.json May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/package.json May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/tsconfig.json May 23 13:46:29 work-volumio volumio[1129]: info: Removing /data/plugins//now_playing/uninstall.sh May 23 13:46:29 work-volumio volumio[1129]: info: Scanning category user_interface May 23 13:46:29 work-volumio volumio[1129]: info: Plugin folders cleanup completed May 23 13:46:29 work-volumio volumio[1129]: info: Error: Error May 23 13:46:29 work-volumio volumio[1129]: info: Error: Error May 23 13:46:29 work-volumio volumio[1129]: info: Folder /tmp/plugins removed May 23 13:46:29 work-volumio volumio[1129]: info: Folder /tmp/downloaded_plugin.zip removed May 23 13:46:29 work-volumio volumio[1129]: info: Folder /data/temp removed May 23 13:46:33 work-volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 23 13:46:34 work-volumio dbus-daemon[584]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.2025' (uid=0 pid=25578 comm="timedatectl show --property=NTPSynchronized --valu") May 23 13:46:34 work-volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 23 13:46:34 work-volumio dbus-daemon[584]: [system] Successfully activated service 'org.freedesktop.timedate1' May 23 13:46:34 work-volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 23 13:46:34 work-volumio setdatetime-helper.sh[25575]: Time is already synchronized. May 23 13:46:34 work-volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 23 13:46:34 work-volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 23 13:46:34 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 23 13:46:38 work-volumio volumio[1129]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/now_playing/1.0.2/volumio/bookworm/armhf May 23 13:46:43 work-volumio volumio[1129]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/now_playing/1.0.2/volumio/bookworm/armhf May 23 13:46:43 work-volumio volumio[1129]: info: Folder /tmp/plugins removed May 23 13:46:47 work-volumio volumio[1129]: info: Check plugin dependencies May 23 13:46:47 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 13:46:47 work-volumio volumio[1129]: info: Checking if plugin already exists May 23 13:46:47 work-volumio volumio[1129]: info: An error occurred installing the plugin. Rolling back config May 23 13:46:47 work-volumio volumio[1129]: info: Plugin folders cleanup May 23 13:46:47 work-volumio volumio[1129]: info: Scanning into folder /volumio/app/plugins/ May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category audio_interface May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category miscellanea May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category music_service May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category plugins.json May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category system_controller May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category user_interface May 23 13:46:47 work-volumio volumio[1129]: info: Scanning into folder /data/plugins/ May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category music_service May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category now_playing May 23 13:46:47 work-volumio volumio[1129]: info: Scanning category user_interface May 23 13:46:47 work-volumio volumio[1129]: info: Plugin folders cleanup completed May 23 13:46:47 work-volumio volumio[1129]: info: Error: Error May 23 13:46:48 work-volumio volumio[1129]: info: Folder /tmp/plugins removed May 23 13:46:48 work-volumio volumio[1129]: info: Folder /tmp/downloaded_plugin.zip removed May 23 13:46:48 work-volumio volumio[1129]: info: Folder /tmp/downloaded_plugin.zip removed May 23 13:46:48 work-volumio volumio[1129]: info: Folder /data/temp removed May 23 13:46:53 work-volumio volumio[1129]: info: Starting Uninstall of plugin user_interface - now_playing May 23 13:46:53 work-volumio volumio[1129]: info: Uninstalling plugin now_playing May 23 13:46:58 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 12 May 23 13:46:58 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:46:58 work-volumio volumio[1129]: info: Prefetching next song May 23 13:46:59 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand addid "https://rr5---sn-p5qlsnrl.googlevideo.com/videoplayback?expire=1748044019&ei=krQwaImaNuy-kucPnaHXcA&ip=65.79.228.85&id=o-ACVBBfR2aBzUuelHwDnI9gX_i0cq703ZOmlrRpiz3dK3&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748022418%2C&mh=ZX&mm=31%2C26&mn=sn-p5qlsnrl%2Csn-vgqsknly&ms=au%2Conr&mv=m&mvi=5&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=us&initcwndbps=4245000&hightc=yes&siu=1&bui=AecWEAameDb81m4VpMm9rLlS-MkB07JvUmCwycF8QZPP50aUR400t_KWS7pwztOwq55I7WJswA&spc=wk1kZss2LcEdHUMPyC5oZhFK3RREKkV8TD5I4enHqj0rZgVGkx7WQVIP2rd0Kk_L0fULSO0Bjz7c&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Opa4GPCcJw-iAWGXgsRgOawQ&rqh=1&gir=yes&clen=7344858&dur=229.261&lmt=1714585911554866&mt=1748022068&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432434&n=EnSgN-Tnnvt2UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRAIgKQNdO4N0eVlRiQd_83qOjHl-e_EuycfgvXtL1Yx37h8CICwO-ZFMDuzRpVEoJfaYxvKoaX0Q7-aKV9R9FKZhPM94&sig=AJfQdSswRQIhANo_8wQ0OD0bcuFdBwnIgABdPnyhOFpbBukVVb45mC5qAiBRC1cbzUtZdxbaFI5Ioahbjn3DzbtnTApGXdvAlxYIMA%3D%3D&pot=Ml-NryRnAJ8UU42TWdiduwN7dSBNaQoH-WFxZm7tfLLbXPSF6EJ7z62PfZkhyPqq_t-ALktsICrXw7FTJmzzW9fa9AYCoA6YYWFTpfL0rpzYyNSYxrQwObK6bwJmPln0CA%3D%3D&cver=1.20250219.01.00&t.YouTube" May 23 13:46:59 work-volumio volumio[1129]: info: May 23 13:46:59 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:46:59 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:46:59 work-volumio volumio[1129]: info: sendMpdCommand addid "https://rr5---sn-p5qlsnrl.googlevideo.com/videoplayback?expire=1748044019&ei=krQwaImaNuy-kucPnaHXcA&ip=65.79.228.85&id=o-ACVBBfR2aBzUuelHwDnI9gX_i0cq703ZOmlrRpiz3dK3&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748022418%2C&mh=ZX&mm=31%2C26&mn=sn-p5qlsnrl%2Csn-vgqsknly&ms=au%2Conr&mv=m&mvi=5&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=us&initcwndbps=4245000&hightc=yes&siu=1&bui=AecWEAameDb81m4VpMm9rLlS-MkB07JvUmCwycF8QZPP50aUR400t_KWS7pwztOwq55I7WJswA&spc=wk1kZss2LcEdHUMPyC5oZhFK3RREKkV8TD5I4enHqj0rZgVGkx7WQVIP2rd0Kk_L0fULSO0Bjz7c&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Opa4GPCcJw-iAWGXgsRgOawQ&rqh=1&gir=yes&clen=7344858&dur=229.261&lmt=1714585911554866&mt=1748022068&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432434&n=EnSgN-Tnnvt2UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRAIgKQNdO4N0eVlRiQd_83qOjHl-e_EuycfgvXtL1Yx37h8CICwO-ZFMDuzRpVEoJfaYxvKoaX0Q7-aKV9R9FKZhPM94&sig=AJfQdSswRQIhANo_8wQ0OD0bcuFdBwnIgABdPnyhOFpbBukVVb45mC5qAiBRC1cbzUtZdxbaFI5Ioahbjn3DzbtnTApGXdvAlxYIMA%3D%3D&pot=Ml-NryRnAJ8UU42TWdiduwN7dSBNaQoH-WFxZm7tfLLbXPSF6EJ7z62PfZkhyPqq_t-ALktsICrXw7FTJmzzW9fa9AYCoA6YYWFTpfL0rpzYyNSYxrQwObK6bwJmPln0CA%3D%3D&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds May 23 13:46:59 work-volumio volumio[1129]: verbose: MPD COMMAND [object Object] May 23 13:46:59 work-volumio volumio[1129]: verbose: MPD COMMAND [object Object] May 23 13:46:59 work-volumio volumio[1129]: verbose: MPD COMMAND [object Object] May 23 13:46:59 work-volumio volumio[1129]: info: May 23 13:46:59 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:46:59 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:46:59 work-volumio volumio[1129]: info: May 23 13:46:59 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:46:59 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:46:59 work-volumio volumio[1129]: info: May 23 13:46:59 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:46:59 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:46:59 work-volumio volumio[1129]: info: May 23 13:46:59 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:46:59 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:46:59 work-volumio volumio[1129]: info: May 23 13:46:59 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:46:59 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:46:59 work-volumio volumio[1129]: info: ------------------------------ 13ms May 23 13:46:59 work-volumio volumio[1129]: info: ------------------------------ 10ms May 23 13:46:59 work-volumio volumio[1129]: info: ------------------------------ 10ms May 23 13:46:59 work-volumio volumio[1129]: info: ------------------------------ 7ms May 23 13:46:59 work-volumio volumio[1129]: info: ------------------------------ 6ms May 23 13:46:59 work-volumio volumio[1129]: info: [ytmusic-play] Prefetched and added track to MPD queue: Authority Song May 23 13:46:59 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand consume 1 May 23 13:46:59 work-volumio volumio[1129]: info: ------------------------------ 6ms May 23 13:46:59 work-volumio volumio[1129]: info: sendMpdCommand consume 1 took 2 milliseconds May 23 13:47:00 work-volumio volumio[1129]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/now_playing/volumio/bookworm/armhf May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: May 23 13:47:03 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:47:03 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:47:03 work-volumio volumio[1129]: info: May 23 13:47:03 work-volumio volumio[1129]: ---------------------------- MPD announces state update: player May 23 13:47:03 work-volumio volumio[1129]: info: ControllerMpd::getState May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status May 23 13:47:03 work-volumio volumio[1129]: info: May 23 13:47:03 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:47:03 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:47:03 work-volumio volumio[1129]: info: May 23 13:47:03 work-volumio volumio[1129]: ---------------------------- MPD announces state update: player May 23 13:47:03 work-volumio volumio[1129]: info: ControllerMpd::getState May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status May 23 13:47:03 work-volumio volumio[1129]: info: May 23 13:47:03 work-volumio volumio[1129]: ---------------------------- MPD announces system playlist update May 23 13:47:03 work-volumio volumio[1129]: info: Ignoring MPD Status Update May 23 13:47:03 work-volumio volumio[1129]: info: May 23 13:47:03 work-volumio volumio[1129]: ---------------------------- MPD announces state update: player May 23 13:47:03 work-volumio volumio[1129]: info: ControllerMpd::getState May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status May 23 13:47:03 work-volumio volumio[1129]: info: ------------------------------ 11ms May 23 13:47:03 work-volumio volumio[1129]: info: sendMpdCommand status took 9 milliseconds May 23 13:47:03 work-volumio volumio[1129]: info: ------------------------------ 7ms May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::parseState May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:47:03 work-volumio volumio[1129]: info: sendMpdCommand status took 8 milliseconds May 23 13:47:03 work-volumio volumio[1129]: info: ------------------------------ 7ms May 23 13:47:03 work-volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds May 23 13:47:03 work-volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::parseState May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::parseState May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo May 23 13:47:03 work-volumio volumio[1129]: info: ControllerMpd::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::servicePushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Authority Song","artist":"John Mellencamp","album":"Uh-HUH!","uri":"https://rr5---sn-p5qlsnrl.googlevideo.com/videoplayback?expire=1748044019&ei=krQwaImaNuy-kucPnaHXcA&ip=65.79.228.85&id=o-ACVBBfR2aBzUuelHwDnI9gX_i0cq703ZOmlrRpiz3dK3&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748022418%2C&mh=ZX&mm=31%2C26&mn=sn-p5qlsnrl%2Csn-vgqsknly&ms=au%2Conr&mv=m&mvi=5&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=us&initcwndbps=4245000&hightc=yes&siu=1&bui=AecWEAameDb81m4VpMm9rLlS-MkB07JvUmCwycF8QZPP50aUR400t_KWS7pwztOwq55I7WJswA&spc=wk1kZss2LcEdHUMPyC5oZhFK3RREKkV8TD5I4enHqj0rZgVGkx7WQVIP2rd0Kk_L0fULSO0Bjz7c&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Opa4GPCcJw-iAWGXgsRgOawQ&rqh=1&gir=yes&clen=7344858&dur=229.261&lmt=1714585911554866&mt=1748022068&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432434&n=EnSgN-Tnnvt2UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRAIgKQNdO4N0eVlRiQd_83qOjHl-e_EuycfgvXtL1Yx37h8CICwO-ZFMDuzRpVEoJfaYxvKoaX0Q7-aKV9R9FKZhPM94&sig=AJfQdSswRQIhANo_8wQ0OD0bcuFdBwnIgABdPnyhOFpbBukVVb45mC5qAiBRC1cbzUtZdxbaFI5Ioahbjn3DzbtnTApGXdvAlxYIMA%3D%3D&pot=Ml-NryRnAJ8UU42TWdiduwN7dSBNaQoH-WFxZm7tfLLbXPSF6EJ7z62PfZkhyPqq_t-ALktsICrXw7FTJmzzW9fa9AYCoA6YYWFTpfL0rpzYyNSYxrQwObK6bwJmPln0CA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 23 13:47:03 work-volumio volumio[1129]: verbose: CURRENT POSITION 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::syncState stateService play May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play May 23 13:47:03 work-volumio volumio[1129]: info: Received an update from plugin. extracting info from payload May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:03 work-volumio volumio[1129]: info: ------------------------------ 33ms May 23 13:47:03 work-volumio volumio[1129]: info: sendMpdCommand playlistinfo took 19 milliseconds May 23 13:47:03 work-volumio volumio[1129]: info: sendMpdCommand playlistinfo took 19 milliseconds May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo May 23 13:47:03 work-volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo May 23 13:47:03 work-volumio volumio[1129]: info: ControllerMpd::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::servicePushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Authority Song","artist":"John Mellencamp","album":"Uh-HUH!","uri":"https://rr5---sn-p5qlsnrl.googlevideo.com/videoplayback?expire=1748044019&ei=krQwaImaNuy-kucPnaHXcA&ip=65.79.228.85&id=o-ACVBBfR2aBzUuelHwDnI9gX_i0cq703ZOmlrRpiz3dK3&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748022418%2C&mh=ZX&mm=31%2C26&mn=sn-p5qlsnrl%2Csn-vgqsknly&ms=au%2Conr&mv=m&mvi=5&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=us&initcwndbps=4245000&hightc=yes&siu=1&bui=AecWEAameDb81m4VpMm9rLlS-MkB07JvUmCwycF8QZPP50aUR400t_KWS7pwztOwq55I7WJswA&spc=wk1kZss2LcEdHUMPyC5oZhFK3RREKkV8TD5I4enHqj0rZgVGkx7WQVIP2rd0Kk_L0fULSO0Bjz7c&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Opa4GPCcJw-iAWGXgsRgOawQ&rqh=1&gir=yes&clen=7344858&dur=229.261&lmt=1714585911554866&mt=1748022068&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432434&n=EnSgN-Tnnvt2UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRAIgKQNdO4N0eVlRiQd_83qOjHl-e_EuycfgvXtL1Yx37h8CICwO-ZFMDuzRpVEoJfaYxvKoaX0Q7-aKV9R9FKZhPM94&sig=AJfQdSswRQIhANo_8wQ0OD0bcuFdBwnIgABdPnyhOFpbBukVVb45mC5qAiBRC1cbzUtZdxbaFI5Ioahbjn3DzbtnTApGXdvAlxYIMA%3D%3D&pot=Ml-NryRnAJ8UU42TWdiduwN7dSBNaQoH-WFxZm7tfLLbXPSF6EJ7z62PfZkhyPqq_t-ALktsICrXw7FTJmzzW9fa9AYCoA6YYWFTpfL0rpzYyNSYxrQwObK6bwJmPln0CA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 23 13:47:03 work-volumio volumio[1129]: verbose: CURRENT POSITION 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::syncState stateService play May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play May 23 13:47:03 work-volumio volumio[1129]: info: Received an update from plugin. extracting info from payload May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:03 work-volumio volumio[1129]: info: ControllerMpd::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::servicePushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Authority Song","artist":"John Mellencamp","album":"Uh-HUH!","uri":"https://rr5---sn-p5qlsnrl.googlevideo.com/videoplayback?expire=1748044019&ei=krQwaImaNuy-kucPnaHXcA&ip=65.79.228.85&id=o-ACVBBfR2aBzUuelHwDnI9gX_i0cq703ZOmlrRpiz3dK3&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748022418%2C&mh=ZX&mm=31%2C26&mn=sn-p5qlsnrl%2Csn-vgqsknly&ms=au%2Conr&mv=m&mvi=5&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=us&initcwndbps=4245000&hightc=yes&siu=1&bui=AecWEAameDb81m4VpMm9rLlS-MkB07JvUmCwycF8QZPP50aUR400t_KWS7pwztOwq55I7WJswA&spc=wk1kZss2LcEdHUMPyC5oZhFK3RREKkV8TD5I4enHqj0rZgVGkx7WQVIP2rd0Kk_L0fULSO0Bjz7c&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Opa4GPCcJw-iAWGXgsRgOawQ&rqh=1&gir=yes&clen=7344858&dur=229.261&lmt=1714585911554866&mt=1748022068&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5432434&n=EnSgN-Tnnvt2UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACuhMU0wRAIgKQNdO4N0eVlRiQd_83qOjHl-e_EuycfgvXtL1Yx37h8CICwO-ZFMDuzRpVEoJfaYxvKoaX0Q7-aKV9R9FKZhPM94&sig=AJfQdSswRQIhANo_8wQ0OD0bcuFdBwnIgABdPnyhOFpbBukVVb45mC5qAiBRC1cbzUtZdxbaFI5Ioahbjn3DzbtnTApGXdvAlxYIMA%3D%3D&pot=Ml-NryRnAJ8UU42TWdiduwN7dSBNaQoH-WFxZm7tfLLbXPSF6EJ7z62PfZkhyPqq_t-ALktsICrXw7FTJmzzW9fa9AYCoA6YYWFTpfL0rpzYyNSYxrQwObK6bwJmPln0CA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} May 23 13:47:03 work-volumio volumio[1129]: verbose: CURRENT POSITION 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::syncState stateService play May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play May 23 13:47:03 work-volumio volumio[1129]: info: Received an update from plugin. extracting info from payload May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:03 work-volumio volumio[1129]: info: ------------------------------ 94ms May 23 13:47:03 work-volumio volumio[1129]: info: ------------------------------ 93ms May 23 13:47:03 work-volumio volumio[1129]: info: [LastFM] Current track has sufficient metadata: title (Authority Song) and artist (John Mellencamp) passed on explicitly May 23 13:47:03 work-volumio volumio[1129]: info: CoreStateMachine::pushState May 23 13:47:03 work-volumio volumio[1129]: info: CorePlayQueue::getTrack 13 May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 13:47:03 work-volumio volumio[1129]: info: CoreCommandRouter::volumioPushState May 23 13:47:04 work-volumio volumio[1129]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Authority Song","mbid":"f5ff19f7-95f3-4a22-8996-3788c264e0b8","url":"https://www.last.fm/music/John+Mellencamp/_/Authority+Song","duration":"230000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"98420","playcount":"345081","artist":{"name":"John Mellencamp","mbid":"0aad6b52-fd93-4ea4-9c5d-1f66e1bc9f0a","url":"https://www.last.fm/music/John+Mellencamp"},"album":{"@":{"position":"13"},"artist":"John Mellencamp","title":"Words & Music: John Mellencamp's Greatest Hits","mbid":"1240c510-7015-4484-baac-ce17f5277ea1","url":"https://www.last.fm/music/John+Mellencamp/Words+&+Music:+John+Mellencamp%27s+Greatest+Hits","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/b280f08a79b95f10e42a579dd6784f64.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/b280f08a79b95f10e42a579dd6784f64.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/b280f08a79b95f10e42a579dd6784f64.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/b280f08a79b95f10e42a579dd6784f64.png","@":{"size":"extralarge"}}]},"userplaycount":"9","userloved":"0","toptags":{"tag":[{"name":"classic rock","url":"https://www.last.fm/tag/classic+rock"},{"name":"rock","url":"https://www.last.fm/tag/rock"},{"name":"80s","url":"https://www.last.fm/tag/80s"},{"name":"mellencamp","url":"https://www.last.fm/tag/mellencamp"},{"name":"pop","url":"https://www.last.fm/tag/pop"}]},"wiki":{"published":"03 Apr 2015, 04:15","summary":"David Thoener recorded this song and the uh-huh album in an empty house in Seymore Indiana with Don Gehman producing. Then Dave and Don went to Record Plant Studios in New York and mixed it in Studio B. Read more on Last.fm.","content":"David Thoener recorded this song and the uh-huh album in an empty house in Seymore Indiana with Don Gehman producing. Then Dave and Don went to Record Plant Studios in New York and mixed it in Studio B. Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} May 23 13:47:04 work-volumio systemd[1]: systemd-timedated.service: Deactivated successfully. May 23 13:47:07 work-volumio volumio[1129]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/now_playing/volumio/bookworm/armhf May 23 13:47:07 work-volumio volumio[1129]: info: An error occurred installing the plugin. Rolling back config May 23 13:47:07 work-volumio volumio[1129]: info: Plugin folders cleanup May 23 13:47:07 work-volumio volumio[1129]: info: Scanning into folder /volumio/app/plugins/ May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category audio_interface May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category miscellanea May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category music_service May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category plugins.json May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category system_controller May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category user_interface May 23 13:47:07 work-volumio volumio[1129]: info: Scanning into folder /data/plugins/ May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category music_service May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category now_playing May 23 13:47:07 work-volumio volumio[1129]: info: Scanning category user_interface May 23 13:47:07 work-volumio volumio[1129]: info: Plugin folders cleanup completed May 23 13:47:07 work-volumio volumio[1129]: info: Error: Error May 23 13:47:07 work-volumio volumio[1129]: info: Error: Error May 23 13:47:07 work-volumio volumio[1129]: info: Folder /data/temp removed May 23 13:47:07 work-volumio volumio[1129]: info: Folder /tmp/plugins removed May 23 13:47:07 work-volumio volumio[1129]: info: Folder /tmp/downloaded_plugin.zip removed May 23 13:47:11 work-volumio sudo[25744]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 23 13:47:11 work-volumio sudo[25742]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 23 13:47:11 work-volumio sudo[25744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:47:11 work-volumio sudo[25742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 13:47:11 work-volumio sudo[25742]: pam_unix(sudo:session): session closed for user root May 23 13:47:11 work-volumio sudo[25744]: pam_unix(sudo:session): session closed for user root May 23 13:47:12 work-volumio volumio[1129]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.108 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 23 13:47:12 work-volumio volumio[1129]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 13:47:12 work-volumio volumio[1129]: TypeError: Cannot read properties of undefined (reading 'plugin_type') May 23 13:47:12 work-volumio volumio[1129]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1644:56) May 23 13:47:12 work-volumio volumio[1129]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1540:29) May 23 13:47:12 work-volumio volumio[1129]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1342:45) May 23 13:47:12 work-volumio volumio[1129]: at Socket.emit (node:events:514:28) May 23 13:47:12 work-volumio volumio[1129]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 23 13:47:12 work-volumio volumio[1129]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) May 23 13:47:12 work-volumio volumio[1129]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) May 23 13:47:12 work-volumio volumio[1129]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 13:47:15 work-volumio sudo[25763]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-23 13:46' May 23 13:47:15 work-volumio sudo[25763]: 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"