May 30 16:49:40 volumio-v4 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
May 30 16:49:41 volumio-v4 systemd[1]: setdatetime-helper.service: Deactivated successfully.
May 30 16:49:41 volumio-v4 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
May 30 16:49:55 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetState
May 30 16:49:57 volumio-v4 volumio[1208]: info: Executing endpoint metavolumio
May 30 16:49:57 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 30 16:50:00 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetQueue
May 30 16:50:00 volumio-v4 volumio[1208]: info: CoreStateMachine::getQueue
May 30 16:50:00 volumio-v4 volumio[1208]: info: CorePlayQueue::getQueue
May 30 16:50:05 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetState
May 30 16:50:07 volumio-v4 volumio[1208]: info: Executing endpoint metavolumio
May 30 16:50:07 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 30 16:50:11 volumio-v4 volumio[1208]: info: Getting Alsa Cards List without I2S DAC
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 30 16:50:11 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 30 16:50:24 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetState
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:26 volumio-v4 volumio[1208]: info: Retrieving Cloud Streaming UI
May 30 16:50:26 volumio-v4 volumio[1208]: info: Getting Tidal Cloud Configuration
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:26 volumio-v4 volumio[1208]: info: Getting Qobuz Cloud Configuration
May 30 16:50:26 volumio-v4 volumio[1208]: info: Asking plugin for UI Config
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:26 volumio-v4 volumio[1208]: info: Getting Spotify Cloud Configuration
May 30 16:50:26 volumio-v4 volumio[1208]: info: Asking plugin for UI Config
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:26 volumio-v4 volumio[1208]: info: Saving Spotify Acccount
May 30 16:50:26 volumio-v4 volumio[1208]: info: Got it
May 30 16:50:26 volumio-v4 volumio[1208]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 30 16:50:26 volumio-v4 volumio[1208]: info: Got Tidal Cloud Configuration
May 30 16:50:26 volumio-v4 volumio[1208]: info: Got it
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources
May 30 16:50:26 volumio-v4 volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources
May 30 16:50:27 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 30 16:50:27 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 30 16:50:27 volumio-v4 volumio[1208]: info: Executing endpoint metavolumio
May 30 16:50:27 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 30 16:50:31 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 30 16:50:32 volumio-v4 volumio[1208]: info: Disabling MyMusic plugin upnp
May 30 16:50:32 volumio-v4 sudo[16074]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 30 16:50:32 volumio-v4 sudo[16074]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 30 16:50:32 volumio-v4 systemd[1]: Stopping upmpdcli.service - UPnP Renderer front-end to MPD...
May 30 16:50:35 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 30 16:50:39 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 30 16:50:42 volumio-v4 volumio[1208]: info: Enabling MyMusic plugin upnp
May 30 16:50:42 volumio-v4 volumio[1208]: info: Enabling plugin upnp
May 30 16:50:42 volumio-v4 volumio[1208]: info: Loading plugin "upnp"...
May 30 16:50:42 volumio-v4 volumio[1208]: info: [1780177842363] Starting Upmpd Daemon
May 30 16:50:42 volumio-v4 volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 30 16:50:42 volumio-v4 volumio[1208]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 30 16:50:42 volumio-v4 volumio[1208]: Error: listen EADDRINUSE: address already in use :::6599
May 30 16:50:42 volumio-v4 volumio[1208]: at Server.setupListenHandle [as _listen2] (node:net:1872:16)
May 30 16:50:42 volumio-v4 volumio[1208]: at listenInCluster (node:net:1920:12)
May 30 16:50:42 volumio-v4 volumio[1208]: at Server.listen (node:net:2008:7)
May 30 16:50:42 volumio-v4 volumio[1208]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 30 16:50:42 volumio-v4 volumio[1208]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 30 16:50:42 volumio-v4 volumio[1208]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 30 16:50:42 volumio-v4 volumio[1208]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 30 16:50:42 volumio-v4 volumio[1208]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) {
May 30 16:50:42 volumio-v4 volumio[1208]: code: 'EADDRINUSE',
May 30 16:50:42 volumio-v4 volumio[1208]: errno: -98,
May 30 16:50:42 volumio-v4 volumio[1208]: syscall: 'listen',
May 30 16:50:42 volumio-v4 volumio[1208]: address: '::',
May 30 16:50:42 volumio-v4 volumio[1208]: port: 6599
May 30 16:50:42 volumio-v4 volumio[1208]: }
May 30 16:50:42 volumio-v4 volumio[1208]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 30 16:50:42 volumio-v4 sudo[16135]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-30 16:49'
May 30 16:50:42 volumio-v4 sudo[16135]: 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"