-- Logs begin at Mon 2026-01-12 18:55:43 GMT, end at Mon 2026-01-12 19:52:43 GMT. -- Jan 12 19:51:04 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Jan 12 19:51:04 volumio5784 volumio[977]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json' Jan 12 19:51:04 volumio5784 volumio[977]: info: Preload queue cleared Jan 12 19:51:17 volumio5784 volumio[977]: error: error Jan 12 19:51:35 volumio5784 volumio[977]: error: error Jan 12 19:51:45 volumio5784 volumio[977]: info: CoreCommandRouter::volumioGetState Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::volumioStop Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::stop Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::stPlaybackTimer Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::updateTrackBlock Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrackBlock Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::pushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrack 0 Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::volumioPushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::serviceStop Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrack 0 Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::serviceStop Jan 12 19:51:46 volumio5784 volumio[977]: info: [1768247506385] ControllerWebradio::stop Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::sendMpdCommand stop Jan 12 19:51:46 volumio5784 volumio[977]: info: sendMpdCommand stop took 8 milliseconds Jan 12 19:51:46 volumio5784 volumio[977]: info: Jan 12 19:51:46 volumio5784 volumio[977]: ---------------------------- MPD announces state update: player Jan 12 19:51:46 volumio5784 volumio[977]: info: ControllerMpd::getState Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::sendMpdCommand status Jan 12 19:51:46 volumio5784 volumio[977]: info: Jan 12 19:51:46 volumio5784 volumio[977]: ---------------------------- MPD announces state update: player Jan 12 19:51:46 volumio5784 volumio[977]: info: ControllerMpd::getState Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::sendMpdCommand status Jan 12 19:51:46 volumio5784 volumio[977]: info: sendMpdCommand status took 8 milliseconds Jan 12 19:51:46 volumio5784 volumio[977]: info: sendMpdCommand status took 1 milliseconds Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::parseState Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::parseState Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 19:51:46 volumio5784 volumio[977]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 12 19:51:46 volumio5784 volumio[977]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::parseTrackInfo Jan 12 19:51:46 volumio5784 volumio[977]: verbose: ControllerMpd::parseTrackInfo Jan 12 19:51:46 volumio5784 volumio[977]: info: ControllerMpd::pushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::servicePushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::pushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrack 0 Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::volumioPushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrack 0 Jan 12 19:51:46 volumio5784 volumio[977]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 12 19:51:46 volumio5784 volumio[977]: info: ControllerMpd::pushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::servicePushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreStateMachine::pushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrack 0 Jan 12 19:51:46 volumio5784 volumio[977]: info: CoreCommandRouter::volumioPushState Jan 12 19:51:46 volumio5784 volumio[977]: info: CorePlayQueue::getTrack 0 Jan 12 19:51:46 volumio5784 volumio[977]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 12 19:51:46 volumio5784 volumio[977]: info: ------------------------------ 29ms Jan 12 19:51:46 volumio5784 volumio[977]: info: ------------------------------ 24ms Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 19:52:19 volumio5784 volumio[977]: info: Retrieving Cloud Streaming UI Jan 12 19:52:19 volumio5784 volumio[977]: info: Getting Tidal Cloud Configuration Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 19:52:19 volumio5784 volumio[977]: info: Getting Qobuz Cloud Configuration Jan 12 19:52:19 volumio5784 volumio[977]: info: Asking plugin for UI Config Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 19:52:19 volumio5784 volumio[977]: info: Getting Spotify Cloud Configuration Jan 12 19:52:19 volumio5784 volumio[977]: info: Asking plugin for UI Config Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 19:52:19 volumio5784 volumio[977]: info: Saving Spotify Acccount Jan 12 19:52:19 volumio5784 volumio[977]: info: Got Tidal Cloud Configuration Jan 12 19:52:19 volumio5784 volumio[977]: info: Got it Jan 12 19:52:19 volumio5784 volumio[977]: info: Got it Jan 12 19:52:19 volumio5784 volumio[977]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 19:52:19 volumio5784 volumio[977]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::volumioGetBrowseSources Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::volumioGetBrowseSources Jan 12 19:52:19 volumio5784 volumio[977]: info: CoreCommandRouter::volumioGetBrowseSources Jan 12 19:52:20 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 12 19:52:20 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 12 19:52:24 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 12 19:52:28 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 12 19:52:32 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 12 19:52:33 volumio5784 volumio[977]: info: Disabling MyMusic plugin upnp Jan 12 19:52:33 volumio5784 sudo[7468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jan 12 19:52:33 volumio5784 sudo[7468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 19:52:33 volumio5784 systemd[1]: Stopping UPnP Renderer front-end to MPD... Jan 12 19:52:33 volumio5784 volumio[977]: error: Upnp client error: Error: This socket has been ended by the other party Jan 12 19:52:34 volumio5784 volumio[977]: info: Disabling MyMusic plugin upnp_browser Jan 12 19:52:34 volumio5784 volumio[977]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Jan 12 19:52:34 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 19:52:34 volumio5784 volumio[977]: info: Disabling plugin upnp_browser Jan 12 19:52:34 volumio5784 volumio[977]: info: Done. Jan 12 19:52:36 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 12 19:52:39 volumio5784 volumio[977]: info: Enabling MyMusic plugin upnp_browser Jan 12 19:52:39 volumio5784 volumio[977]: info: Enabling plugin upnp_browser Jan 12 19:52:39 volumio5784 volumio[977]: info: Loading plugin "upnp_browser"... Jan 12 19:52:39 volumio5784 volumio[977]: info: PLUGIN START: upnp_browser Jan 12 19:52:39 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 19:52:39 volumio5784 volumio[977]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 12 19:52:39 volumio5784 volumio[977]: info: [1768247559313] CoreMusicLibrary::Adding element Media Servers Jan 12 19:52:39 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 19:52:39 volumio5784 volumio[977]: info: Done. Jan 12 19:52:40 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 12 19:52:40 volumio5784 volumio[977]: info: Disabling MyMusic plugin upnp Jan 12 19:52:40 volumio5784 sudo[7485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jan 12 19:52:40 volumio5784 sudo[7485]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 19:52:43 volumio5784 volumio[977]: info: Enabling MyMusic plugin upnp Jan 12 19:52:43 volumio5784 volumio[977]: info: Enabling plugin upnp Jan 12 19:52:43 volumio5784 volumio[977]: info: Loading plugin "upnp"... Jan 12 19:52:43 volumio5784 volumio[977]: info: [1768247563309] Starting Upmpd Daemon Jan 12 19:52:43 volumio5784 volumio[977]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 12 19:52:43 volumio5784 volumio[977]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 19:52:43 volumio5784 volumio[977]: Error: listen EADDRINUSE: address already in use :::6599 Jan 12 19:52:43 volumio5784 volumio[977]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jan 12 19:52:43 volumio5784 volumio[977]: at listenInCluster (net.js:1366:12) Jan 12 19:52:43 volumio5784 volumio[977]: at Server.listen (net.js:1452:7) Jan 12 19:52:43 volumio5784 volumio[977]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jan 12 19:52:43 volumio5784 volumio[977]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jan 12 19:52:43 volumio5784 volumio[977]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jan 12 19:52:43 volumio5784 volumio[977]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 12 19:52:43 volumio5784 volumio[977]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jan 12 19:52:43 volumio5784 volumio[977]: code: 'EADDRINUSE', Jan 12 19:52:43 volumio5784 volumio[977]: errno: -98, Jan 12 19:52:43 volumio5784 volumio[977]: syscall: 'listen', Jan 12 19:52:43 volumio5784 volumio[977]: address: '::', Jan 12 19:52:43 volumio5784 volumio[977]: port: 6599 Jan 12 19:52:43 volumio5784 volumio[977]: } Jan 12 19:52:43 volumio5784 volumio[977]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 19:52:43 volumio5784 sudo[7502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 19:51 Jan 12 19:52:43 volumio5784 sudo[7502]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"