Aug 26 00:18:03 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:03 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:13 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:13 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:23 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:23 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:24 volumio sudo[6872]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:24 volumio sudo[6872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:24 volumio sudo[6872]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:24 volumio sudo[6874]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:24 volumio sudo[6874]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:24 volumio sudo[6874]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:24 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 00:18:24 volumio sudo[6878]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:24 volumio sudo[6878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:24 volumio sudo[6878]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:24 volumio sudo[6880]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:24 volumio sudo[6880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:24 volumio sudo[6880]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:24 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 00:18:24 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 00:18:24 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 00:18:30 volumio sudo[6910]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:30 volumio sudo[6910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:30 volumio sudo[6910]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:30 volumio sudo[6912]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:30 volumio sudo[6912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:30 volumio sudo[6912]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:30 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 00:18:30 volumio sudo[6916]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:30 volumio sudo[6916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:30 volumio sudo[6916]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:30 volumio sudo[6918]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:30 volumio sudo[6918]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:30 volumio sudo[6918]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:30 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 00:18:30 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 00:18:30 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 00:18:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 00:18:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 00:18:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 00:18:33 volumio sudo[6928]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:33 volumio sudo[6928]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:33 volumio sudo[6928]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:33 volumio sudo[6930]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:33 volumio sudo[6930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:33 volumio sudo[6930]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:33 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 26 00:18:33 volumio sudo[6934]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:33 volumio sudo[6934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:33 volumio sudo[6934]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:33 volumio sudo[6936]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:33 volumio sudo[6936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:33 volumio sudo[6936]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:33 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 00:18:33 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:36 volumio sudo[6963]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:36 volumio sudo[6963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:36 volumio sudo[6963]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:36 volumio sudo[6965]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:36 volumio sudo[6965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:36 volumio sudo[6965]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:36 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 00:18:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 00:18:37 volumio sudo[6971]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 00:18:37 volumio sudo[6971]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:37 volumio sudo[6971]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:37 volumio sudo[6973]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 00:18:37 volumio sudo[6973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 00:18:37 volumio sudo[6973]: pam_unix(sudo:session): session closed for user root Aug 26 00:18:37 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 00:18:37 volumio volumio[1301]: info: Discovery: Getting this device information Aug 26 00:18:37 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:37 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 00:18:38 volumio volumio[1301]: info: [now-playing] Weather not configured: Weather is not set up: add Geographic Coordinates in Localization and an OpenWeatherMap API key in Weather Service. Aug 26 00:18:38 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6:3000 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 26 00:18:38 volumio volumio[1301]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 26 00:18:38 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 26 00:18:38 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:38 volumio volumio[1301]: info: CoreCommandRouter::volumioGetQueue Aug 26 00:18:38 volumio volumio[1301]: info: CoreStateMachine::getQueue Aug 26 00:18:38 volumio volumio[1301]: info: CorePlayQueue::getQueue Aug 26 00:18:38 volumio volumio[1301]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 00:18:38 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 00:18:38 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:39 volumio volumio[1301]: info: [now-playing] Weather not configured: Weather is not set up: add Geographic Coordinates in Localization and an OpenWeatherMap API key in Weather Service. Aug 26 00:18:39 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6:3000 from 192.168.0.36 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 26 00:18:40 volumio volumio[1301]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 26 00:18:40 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 26 00:18:40 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:40 volumio volumio[1301]: info: CoreCommandRouter::volumioGetQueue Aug 26 00:18:40 volumio volumio[1301]: info: CoreStateMachine::getQueue Aug 26 00:18:40 volumio volumio[1301]: info: CorePlayQueue::getQueue Aug 26 00:18:40 volumio volumio[1301]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 00:18:40 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 00:18:40 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:43 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:43 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:18:53 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:18:53 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:03 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:03 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:03 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:05 volumio volumio[1301]: info: [now-playing] Weather not configured: Weather is not set up: add Geographic Coordinates in Localization and an OpenWeatherMap API key in Weather Service. Aug 26 00:19:05 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.0.6:3000 from 192.168.0.3 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 OPR/90.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 00:19:08 volumio volumio[1301]: info: Preload queue cleared Aug 26 00:19:08 volumio volumio[1301]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 26 00:19:08 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetQueue Aug 26 00:19:08 volumio volumio[1301]: info: CoreStateMachine::getQueue Aug 26 00:19:08 volumio volumio[1301]: info: CorePlayQueue::getQueue Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 00:19:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:13 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:13 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:13 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 26 00:19:13 volumio volumio[1301]: info: Preload queue cleared Aug 26 00:19:15 volumio volumio[1301]: info: Preload queue cleared Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::ClearQueue Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::stPlaybackTimer Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::updateTrackBlock Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrackBlock Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::serviceStop Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::serviceStop Aug 26 00:19:15 volumio volumio[1301]: info: [1787728755223] ControllerPandora::stop Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::stop Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::clearPlayQueue Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::saveQueue Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushQueue Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::addQueueItems Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::addQueueItems Aug 26 00:19:15 volumio volumio[1301]: info: Preload queue cleared Aug 26 00:19:15 volumio volumio[1301]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s190314 Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.245-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_STOPPED positionMs=0 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.246-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand stop took 85 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::clear Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand status took 5 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand clear took 6 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand status took 4 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand status took 3 milliseconds Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:15 volumio volumio[1301]: info: [1787728755317] ControllerPandora::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Hi Scores","name":"Hi Scores","artist":"Boards of Canada","album":"Hi Scores","albumart":"http://cont-1.p-cdn.us/images/e1/43/63/72/c516426599f313671573a795/1080W_1080H.jpg","realUri":"http://audio-usc-mp1-t3-1-v4v6.pandora.com/access/7059924689525278637.mp3?version=5&lid=47794088&token=BzPE69iz9b0TEvusGTp3Tbufax%2BK3LUzcrbtZKDbee%2B48yyaCFfH5UrdS3oeZp9f5uTEiHdROFcNhHiYaAkX3mnno4bhvBhwB%2BiInykdL6gGt2JPqI85ZPbzuo89YIElB4YCh0suRA74KfVFCbjxexAWCFsQaCFMP%2BEubpoqr%2FJX6lm8XzYeLElDJJy4mjREr3ZqHt3bcmGREuO5EFbTElHOrdPHHD7Xm5CvRG8To7v2JPm9ug7etmTI8FA7mCcH05fJK3ii4Ew6laoFXTpczGny72LKZn5RaIVH5wSup4g%2BqPsAtUvLRAAthiyUmgN8KjgEJfDvM%2BDO%2Bl3QyQkX9g%3D%3D","isStreaming":true,"duration":297,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://audio-usc-mp1-t3-1-v4v6.pandora.com/access/7059924689525278637.mp3?version=5&lid=47794088&token=BzPE69iz9b0TEvusGTp3Tbufax%2BK3LUzcrbtZKDbee%2B48yyaCFfH5UrdS3oeZp9f5uTEiHdROFcNhHiYaAkX3mnno4bhvBhwB%2BiInykdL6gGt2JPqI85ZPbzuo89YIElB4YCh0suRA74KfVFCbjxexAWCFsQaCFMP%2BEubpoqr%2FJX6lm8XzYeLElDJJy4mjREr3ZqHt3bcmGREuO5EFbTElHOrdPHHD7Xm5CvRG8To7v2JPm9ug7etmTI8FA7mCcH05fJK3ii4Ew6laoFXTpczGny72LKZn5RaIVH5wSup4g%2BqPsAtUvLRAAthiyUmgN8KjgEJfDvM%2BDO%2Bl3QyQkX9g%3D%3D","seek":0,"status":"stop"} Aug 26 00:19:15 volumio volumio[1301]: verbose: CURRENT POSITION 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: No code Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.357-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_STOPPED positionMs=0 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.358-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id= title= Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.360-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_STOPPED positionMs=0 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.360-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id= title= Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.362-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_STOPPED positionMs=0 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.363-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id= title= Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 00:19:15 volumio volumio[1301]: verbose: CURRENT POSITION 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: No code Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 1 Aug 26 00:19:15 volumio volumio[1301]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 00:19:15 volumio volumio[1301]: verbose: CURRENT POSITION 1 Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio[1301]: info: No code Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.431-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=502 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.431-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.433-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=502 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.434-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.436-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=502 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.437-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.438-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=502 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.439-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.441-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=502 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.441-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.443-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=502 volume=88 Aug 26 00:19:15 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:15.444-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id="/pandora/stationToken=1952444677715740584trackId=7059924689525278637" title="Hi Scores" Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 161ms Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 160ms Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: error: updateQueue error: null Aug 26 00:19:15 volumio volumio[1301]: error: updateQueue error: null Aug 26 00:19:15 volumio volumio[1301]: error: updateQueue error: null Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 164ms Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 162 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 5ms Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 4ms Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:15 volumio volumio[1301]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 172ms Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPushQueue Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::saveQueue Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::updateTrackBlock Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrackBlock Aug 26 00:19:15 volumio volumio[1301]: info: CoreCommandRouter::volumioPlay Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::play index 0 Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::stop Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::play index undefined Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::startPlaybackTimer Aug 26 00:19:15 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:15 volumio volumio[1301]: info: [1787728755668] ControllerWebradio::clearAddPlayTrack Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand stop took 3 milliseconds Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand clear took 2 milliseconds Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand load "http://s.stereoscenic.com/asp-h.pls" Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: error: updateQueue error: null Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 5ms Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand load "http://s.stereoscenic.com/asp-h.pls" took 86 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 26 00:19:15 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand play Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 89ms Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 88ms Aug 26 00:19:15 volumio volumio[1301]: info: sendMpdCommand play took 3 milliseconds Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: Aug 26 00:19:15 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:15 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 5ms Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 2ms Aug 26 00:19:15 volumio volumio[1301]: info: ------------------------------ 1ms Aug 26 00:19:16 volumio snapserver[1067]: State changed: default, state: playing => idle Aug 26 00:19:16 volumio snapserver[1067]: onStateChanged (default): idle Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 6 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 5 milliseconds Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 13 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 10 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 10 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ambient Sleeping Pill","artist":null,"album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ambient Sleeping Pill","artist":null,"album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 38ms Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.262-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.263-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.265-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.266-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 62ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 53 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 49 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 49 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 49 milliseconds Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ambient Sleeping Pill","artist":null,"album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ambient Sleeping Pill","artist":null,"album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ambient Sleeping Pill","artist":null,"album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.379-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.379-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.382-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.382-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.383-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.383-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.386-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.387-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.390-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.391-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.394-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=0 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.395-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 231ms Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 231ms Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 231ms Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:16 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 212 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ambient Sleeping Pill","artist":null,"album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio snapserver[1067]: State changed: default, state: idle => playing Aug 26 00:19:16 volumio snapserver[1067]: onStateChanged (default): playing Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.632-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.633-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.635-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.636-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Ambient Sleeping Pill" Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 445ms Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:16 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:16 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:16 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 191ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 189 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 10ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 10 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 8ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 7 milliseconds Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:16 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces system playlist update Aug 26 00:19:16 volumio volumio[1301]: info: Ignoring MPD Status Update Aug 26 00:19:16 volumio volumio[1301]: info: Aug 26 00:19:16 volumio volumio[1301]: ---------------------------- MPD announces state update: player Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::getState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand status Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 22ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 20 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 15ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 14 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 14ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand status took 13 milliseconds Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseState Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Manual - Always Alone","artist":"Ambient Sleeping Pill","album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":274,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Manual - Always Alone","artist":"Ambient Sleeping Pill","album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":274,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Manual - Always Alone","artist":"Ambient Sleeping Pill","album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.774-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.775-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.777-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.778-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.780-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.781-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.783-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.784-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.788-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.788-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.791-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=321 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.792-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 332ms Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 153ms Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 152ms Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 131 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 130 milliseconds Aug 26 00:19:16 volumio volumio[1301]: info: sendMpdCommand playlistinfo took 130 milliseconds Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: verbose: ControllerMpd::parseTrackInfo Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":274,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Manual - Always Alone","artist":"Ambient Sleeping Pill","album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Manual - Always Alone","artist":"Ambient Sleeping Pill","album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: ControllerMpd::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Aug 26 00:19:16 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Aug 26 00:19:16 volumio volumio[1301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Manual - Always Alone","artist":"Ambient Sleeping Pill","album":null,"uri":"http://radio.stereoscenic.com/asp-h","trackType":"com/asp-h"} Aug 26 00:19:16 volumio volumio[1301]: verbose: CURRENT POSITION 0 Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState stateService play Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus play Aug 26 00:19:16 volumio volumio[1301]: info: Received an update from plugin. extracting info from payload Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreStateMachine::pushState Aug 26 00:19:16 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.928-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=665 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.929-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.931-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=665 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.932-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.934-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=665 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.935-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.937-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=665 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.939-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.940-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=665 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.941-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.943-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" state=STATUS_PLAYING positionMs=665 volume=88 Aug 26 00:19:16 volumio volumio5-onboarding[1769]: time=2026-08-26T00:19:16.943-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.3:54192 @ 0x2c006f0" id=http://radio.stereoscenic.com/asp-h title="Manual - Always Alone" Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 292ms Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 285ms Aug 26 00:19:16 volumio volumio[1301]: info: ------------------------------ 284ms Aug 26 00:19:17 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 00:19:17 volumio volumio[1301]: info: CURURI: artists:// Aug 26 00:19:17 volumio volumio[1301]: info: Preload queue cleared Aug 26 00:19:23 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:23 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:23 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:26 volumio volumio[1301]: info: Preload queue cleared Aug 26 00:19:31 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 00:19:31 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 00:19:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:37 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 00:19:40 volumio volumio[1301]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Noosa/683422ff-9203-4c38-937b-53b831ba1eca.jpg' Aug 26 00:19:40 volumio volumio[1301]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/OhGr/9ac28ba7-917e-4b2c-86dd-3707555e7f07.jpg' Aug 26 00:19:40 volumio volumio[1301]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Orbital/e9d4fcf2-36f6-4c78-a362-de6899e5c9a3.jpg' Aug 26 00:19:43 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:43 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Aug 26 00:19:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:43 volumio volumio[1301]: info: Listing playlists Aug 26 00:19:45 volumio volumio[1301]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 00:19:45 volumio volumio[1301]: AggregateError Aug 26 00:19:45 volumio volumio[1301]: at internalConnectMultiple (node:net:1114:18) Aug 26 00:19:45 volumio volumio[1301]: at afterConnectMultiple (node:net:1667:5) { Aug 26 00:19:45 volumio volumio[1301]: code: 'ECONNREFUSED', Aug 26 00:19:45 volumio volumio[1301]: [errors]: [ Aug 26 00:19:45 volumio volumio[1301]: Error: connect ECONNREFUSED 158.69.209.125:443 Aug 26 00:19:45 volumio volumio[1301]: at createConnectionError (node:net:1634:14) Aug 26 00:19:45 volumio volumio[1301]: at afterConnectMultiple (node:net:1664:40) { Aug 26 00:19:45 volumio volumio[1301]: errno: -111, Aug 26 00:19:45 volumio volumio[1301]: code: 'ECONNREFUSED', Aug 26 00:19:45 volumio volumio[1301]: syscall: 'connect', Aug 26 00:19:45 volumio volumio[1301]: address: '158.69.209.125', Aug 26 00:19:45 volumio volumio[1301]: port: 443 Aug 26 00:19:45 volumio volumio[1301]: }, Aug 26 00:19:45 volumio volumio[1301]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 26 00:19:45 volumio volumio[1301]: at createConnectionError (node:net:1634:14) Aug 26 00:19:45 volumio volumio[1301]: at afterConnectMultiple (node:net:1664:40) { Aug 26 00:19:45 volumio volumio[1301]: errno: -111, Aug 26 00:19:45 volumio volumio[1301]: code: 'ECONNREFUSED', Aug 26 00:19:45 volumio volumio[1301]: syscall: 'connect', Aug 26 00:19:45 volumio volumio[1301]: address: '158.69.210.98', Aug 26 00:19:45 volumio volumio[1301]: port: 443 Aug 26 00:19:45 volumio volumio[1301]: } Aug 26 00:19:45 volumio volumio[1301]: ] Aug 26 00:19:45 volumio volumio[1301]: } Aug 26 00:19:45 volumio volumio[1301]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 00:19:46 volumio sudo[7247]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-26 00:18' Aug 26 00:19:46 volumio sudo[7247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"