-- Logs begin at Fri 2026-02-06 19:56:37 CET, end at Fri 2026-02-06 22:35:17 CET. --
Feb 06 22:34:07 volumio go-librespot[1551]: time="2026-02-06T22:34:07+01:00" level=trace msg="sent dealer ping"
Feb 06 22:34:07 volumio go-librespot[1551]: time="2026-02-06T22:34:07+01:00" level=trace msg="received dealer pong"
Feb 06 22:34:37 volumio go-librespot[1551]: time="2026-02-06T22:34:37+01:00" level=trace msg="sent dealer ping"
Feb 06 22:34:37 volumio go-librespot[1551]: time="2026-02-06T22:34:37+01:00" level=trace msg="received dealer pong"
Feb 06 22:34:58 volumio volumio[945]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object]
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions
Feb 06 22:34:58 volumio sudo[4158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 06 22:34:58 volumio sudo[4158]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 22:34:58 volumio sudo[4158]: pam_unix(sudo:session): session closed for user root
Feb 06 22:34:58 volumio volumio[945]: info: MPD Permissions set
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio sudo[4164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 06 22:34:58 volumio sudo[4164]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 22:34:58 volumio systemd[1]: Stopping Music Player Daemon...
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 06 22:34:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 06 22:34:58 volumio systemd[1]: mpd.service: Succeeded.
Feb 06 22:34:58 volumio systemd[1]: Stopped Music Player Daemon.
Feb 06 22:34:58 volumio systemd[1]: Starting Music Player Daemon...
Feb 06 22:34:58 volumio sudo[4172]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 06 22:34:58 volumio sudo[4172]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 22:34:58 volumio sudo[4172]: pam_unix(sudo:session): session closed for user root
Feb 06 22:34:58 volumio mpd[4174]: Feb 06 22:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 06 22:34:58 volumio systemd[1]: Started Music Player Daemon.
Feb 06 22:34:58 volumio sudo[4164]: pam_unix(sudo:session): session closed for user root
Feb 06 22:34:58 volumio volumio[945]: error: updateQueue error: null
Feb 06 22:34:59 volumio volumio[945]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 06 22:35:01 volumio sudo[4195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Feb 06 22:35:01 volumio sudo[4195]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 22:35:01 volumio systemd[1]: Stopping MPD Monitor Service...
Feb 06 22:35:01 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Feb 06 22:35:01 volumio systemd[1]: mpd_monitor.service: Succeeded.
Feb 06 22:35:01 volumio systemd[1]: Stopped MPD Monitor Service.
Feb 06 22:35:01 volumio systemd[1]: Started MPD Monitor Service.
Feb 06 22:35:01 volumio sudo[4195]: pam_unix(sudo:session): session closed for user root
Feb 06 22:35:01 volumio mpd_monitor.sh[4197]: MPD Monitor Service: Starting MPD Monitor Service
Feb 06 22:35:01 volumio volumio[945]: info: Successfully started MPD Monitor
Feb 06 22:35:07 volumio go-librespot[1551]: time="2026-02-06T22:35:07+01:00" level=trace msg="received accesspoint ping"
Feb 06 22:35:07 volumio go-librespot[1551]: time="2026-02-06T22:35:07+01:00" level=trace msg="received accesspoint pong ack"
Feb 06 22:35:07 volumio go-librespot[1551]: time="2026-02-06T22:35:07+01:00" level=trace msg="sent dealer ping"
Feb 06 22:35:07 volumio go-librespot[1551]: time="2026-02-06T22:35:07+01:00" level=trace msg="received dealer pong"
Feb 06 22:35:10 volumio volumio[945]: info: CoreCommandRouter::volumioGetState
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 22:35:12 volumio volumio[945]: info: Retrieving Cloud Streaming UI
Feb 06 22:35:12 volumio volumio[945]: info: Getting Tidal Cloud Configuration
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 22:35:12 volumio volumio[945]: info: Getting Qobuz Cloud Configuration
Feb 06 22:35:12 volumio volumio[945]: info: Asking plugin for UI Config
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 22:35:12 volumio volumio[945]: info: Getting Spotify Cloud Configuration
Feb 06 22:35:12 volumio volumio[945]: info: Asking plugin for UI Config
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 22:35:12 volumio volumio[945]: info: Saving Spotify Acccount
Feb 06 22:35:12 volumio volumio[945]: info: Got Tidal Cloud Configuration
Feb 06 22:35:12 volumio volumio[945]: info: Got it
Feb 06 22:35:12 volumio volumio[945]: info: Got it
Feb 06 22:35:12 volumio volumio[945]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 22:35:12 volumio volumio[945]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 06 22:35:12 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 06 22:35:16 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 06 22:35:16 volumio volumio[945]: info: Disabling MyMusic plugin upnp
Feb 06 22:35:16 volumio sudo[4290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Feb 06 22:35:16 volumio sudo[4290]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 22:35:16 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
Feb 06 22:35:16 volumio volumio[945]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 06 22:35:17 volumio volumio[945]: info: Enabling MyMusic plugin upnp
Feb 06 22:35:17 volumio volumio[945]: info: Enabling plugin upnp
Feb 06 22:35:17 volumio volumio[945]: info: Loading plugin "upnp"...
Feb 06 22:35:17 volumio volumio[945]: info: [1770413717680] Starting Upmpd Daemon
Feb 06 22:35:17 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 06 22:35:17 volumio volumio[945]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 06 22:35:17 volumio volumio[945]: Error: listen EADDRINUSE: address already in use :::6599
Feb 06 22:35:17 volumio volumio[945]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Feb 06 22:35:17 volumio volumio[945]: at listenInCluster (net.js:1379:12)
Feb 06 22:35:17 volumio volumio[945]: at Server.listen (net.js:1465:7)
Feb 06 22:35:17 volumio volumio[945]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Feb 06 22:35:17 volumio volumio[945]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Feb 06 22:35:17 volumio volumio[945]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Feb 06 22:35:17 volumio volumio[945]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Feb 06 22:35:17 volumio volumio[945]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Feb 06 22:35:17 volumio volumio[945]: code: 'EADDRINUSE',
Feb 06 22:35:17 volumio volumio[945]: errno: -98,
Feb 06 22:35:17 volumio volumio[945]: syscall: 'listen',
Feb 06 22:35:17 volumio volumio[945]: address: '::',
Feb 06 22:35:17 volumio volumio[945]: port: 6599
Feb 06 22:35:17 volumio volumio[945]: }
Feb 06 22:35:17 volumio volumio[945]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 06 22:35:17 volumio sudo[4303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-06 22:34
Feb 06 22:35:17 volumio sudo[4303]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:18:30 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="33f9369b544b4488ff4979d2ee3813a5"