-- Logs begin at Tue 2025-05-13 20:24:50 CEST, end at Tue 2025-05-13 20:28:08 CEST. -- May 13 20:27:12 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 20:27:12 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 20:27:12 volumio volumio[872]: info: Discovery: Getting this device information May 13 20:27:12 volumio volumio[872]: info: CoreCommandRouter::volumioGetState May 13 20:27:12 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 20:27:42 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 20:27:42 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 20:27:42 volumio volumio[872]: info: Discovery: Getting this device information May 13 20:27:42 volumio volumio[872]: info: CoreCommandRouter::volumioGetState May 13 20:27:42 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 20:27:50 volumio volumio[872]: error: Upnp client error: Error: This socket has been ended by the other party May 13 20:27:53 volumio volumio[872]: info: May 13 20:27:53 volumio volumio[872]: ---------------------------- MPD announces state update: player May 13 20:27:53 volumio volumio[872]: info: ControllerMpd::getState May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::sendMpdCommand status May 13 20:27:53 volumio volumio[872]: info: May 13 20:27:53 volumio volumio[872]: ---------------------------- MPD announces state update: player May 13 20:27:53 volumio volumio[872]: info: ControllerMpd::getState May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::sendMpdCommand status May 13 20:27:53 volumio volumio[872]: info: sendMpdCommand status took 4 milliseconds May 13 20:27:53 volumio volumio[872]: info: sendMpdCommand status took 1 milliseconds May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::parseState May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::parseState May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 20:27:53 volumio volumio[872]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 20:27:53 volumio volumio[872]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::parseTrackInfo May 13 20:27:53 volumio volumio[872]: verbose: ControllerMpd::parseTrackInfo May 13 20:27:53 volumio volumio[872]: info: ControllerMpd::pushState May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::servicePushState May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::pushState May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::volumioPushState May 13 20:27:53 volumio volumio[872]: info: CorePlayQueue::getTrack 0 May 13 20:27:53 volumio volumio[872]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Retrograde","artist":"James Blake","album":"Overgrown","uri":"http://192.168.3.250:52100/Music/F60802.flac","trackType":"flac"} May 13 20:27:53 volumio volumio[872]: verbose: CURRENT POSITION 0 May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::syncState stateService stop May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::syncState currentStatus play May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::volumioPushState May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::stPlaybackTimer May 13 20:27:53 volumio volumio[872]: info: ControllerMpd::pushState May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::servicePushState May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::pushState May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::volumioPushState May 13 20:27:53 volumio volumio[872]: info: CorePlayQueue::getTrack 0 May 13 20:27:53 volumio volumio[872]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Retrograde","artist":"James Blake","album":"Overgrown","uri":"http://192.168.3.250:52100/Music/F60802.flac","trackType":"flac"} May 13 20:27:53 volumio volumio[872]: verbose: CURRENT POSITION 0 May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::syncState stateService stop May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::syncState currentStatus stop May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::pushState May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::volumioPushState May 13 20:27:53 volumio volumio[872]: info: No code May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::pushState May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::volumioPushState May 13 20:27:53 volumio volumio[872]: info: ------------------------------ 84ms May 13 20:27:53 volumio volumio[872]: info: ------------------------------ 83ms May 13 20:27:53 volumio volumio[872]: info: CoreCommandRouter::volumioGetQueue May 13 20:27:53 volumio volumio[872]: info: CoreStateMachine::getQueue May 13 20:27:53 volumio volumio[872]: info: CorePlayQueue::getQueue May 13 20:27:58 volumio volumio[872]: info: CoreCommandRouter::volumioGetState May 13 20:27:59 volumio volumio[872]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 20:27:59 volumio volumio[872]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 20:27:59 volumio volumio[872]: info: Retrieving Cloud Streaming UI May 13 20:28:00 volumio volumio[872]: info: Getting Tidal Cloud Configuration May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 20:28:00 volumio volumio[872]: info: Getting Qobuz Cloud Configuration May 13 20:28:00 volumio volumio[872]: info: Asking plugin for UI Config May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 20:28:00 volumio volumio[872]: info: Getting Spotify Cloud Configuration May 13 20:28:00 volumio volumio[872]: info: Asking plugin for UI Config May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 20:28:00 volumio volumio[872]: info: Saving Spotify Acccount May 13 20:28:00 volumio volumio[872]: info: Got Tidal Cloud Configuration May 13 20:28:00 volumio volumio[872]: info: Got it May 13 20:28:00 volumio volumio[872]: info: Got it May 13 20:28:00 volumio volumio[872]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 20:28:00 volumio volumio[872]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::volumioGetBrowseSources May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::volumioGetBrowseSources May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::volumioGetBrowseSources May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 13 20:28:00 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 13 20:28:01 volumio volumio[872]: info: Disabling MyMusic plugin upnp May 13 20:28:01 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 13 20:28:01 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 20:28:01 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... May 13 20:28:01 volumio volumio[872]: error: Upnp client error: Error: This socket has been ended by the other party May 13 20:28:04 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 13 20:28:07 volumio volumio[872]: info: Enabling MyMusic plugin upnp May 13 20:28:07 volumio volumio[872]: info: Enabling plugin upnp May 13 20:28:07 volumio volumio[872]: info: Loading plugin "upnp"... May 13 20:28:07 volumio volumio[872]: info: [1747160887899] Starting Upmpd Daemon May 13 20:28:07 volumio volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 13 20:28:07 volumio volumio[872]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 20:28:07 volumio volumio[872]: Error: listen EADDRINUSE: address already in use :::6599 May 13 20:28:07 volumio volumio[872]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) May 13 20:28:07 volumio volumio[872]: at listenInCluster (net.js:1379:12) May 13 20:28:07 volumio volumio[872]: at Server.listen (net.js:1465:7) May 13 20:28:07 volumio volumio[872]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 13 20:28:07 volumio volumio[872]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 13 20:28:07 volumio volumio[872]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 13 20:28:07 volumio volumio[872]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 13 20:28:07 volumio volumio[872]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { May 13 20:28:07 volumio volumio[872]: code: 'EADDRINUSE', May 13 20:28:07 volumio volumio[872]: errno: -98, May 13 20:28:07 volumio volumio[872]: syscall: 'listen', May 13 20:28:07 volumio volumio[872]: address: '::', May 13 20:28:07 volumio volumio[872]: port: 6599 May 13 20:28:07 volumio volumio[872]: } May 13 20:28:07 volumio volumio[872]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 20:28:08 volumio sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 20:27 May 13 20:28:08 volumio sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"