-- Logs begin at Fri 2025-05-23 16:53:55 CEST, end at Fri 2025-05-23 17:47:33 CEST. -- May 23 17:46:03 volumio go-librespot[1668]: time="2025-05-23T17:46:03+02:00" level=trace msg="received accesspoint ping" May 23 17:46:03 volumio go-librespot[1668]: time="2025-05-23T17:46:03+02:00" level=trace msg="received accesspoint pong ack" May 23 17:46:03 volumio go-librespot[1668]: time="2025-05-23T17:46:03+02:00" level=trace msg="sent dealer ping" May 23 17:46:03 volumio go-librespot[1668]: time="2025-05-23T17:46:03+02:00" level=trace msg="received dealer pong" May 23 17:46:33 volumio go-librespot[1668]: time="2025-05-23T17:46:33+02:00" level=trace msg="sent dealer ping" May 23 17:46:33 volumio go-librespot[1668]: time="2025-05-23T17:46:33+02:00" level=trace msg="received dealer pong" May 23 17:47:03 volumio go-librespot[1668]: time="2025-05-23T17:47:03+02:00" level=trace msg="sent dealer ping" May 23 17:47:03 volumio go-librespot[1668]: time="2025-05-23T17:47:03+02:00" level=trace msg="received dealer pong" May 23 17:47:05 volumio sudo[9588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 23 17:47:05 volumio sudo[9588]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 17:47:05 volumio sudo[9588]: pam_unix(sudo:session): session closed for user root May 23 17:47:05 volumio sudo[9591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 23 17:47:05 volumio sudo[9591]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 17:47:05 volumio sudo[9591]: pam_unix(sudo:session): session closed for user root May 23 17:47:05 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.11 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 23 17:47:05 volumio volumio[1047]: info: Received Get System Info May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 17:47:05 volumio volumio[1047]: info: Discovery: Getting this device information May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:05 volumio volumio[1047]: info: Listing playlists May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 23 17:47:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 23 17:47:06 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:06 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 23 17:47:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 23 17:47:07 volumio volumio[1047]: info: Received Get System Info May 23 17:47:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 17:47:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 17:47:07 volumio volumio[1047]: info: Discovery: Getting this device information May 23 17:47:07 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 17:47:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 23 17:47:08 volumio volumio[1047]: info: Received Get System Info May 23 17:47:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 17:47:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 17:47:08 volumio volumio[1047]: info: Discovery: Getting this device information May 23 17:47:08 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 23 17:47:10 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 23 17:47:15 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 23 17:47:20 volumio volumio[1047]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions May 23 17:47:20 volumio sudo[9618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 23 17:47:20 volumio sudo[9618]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 17:47:20 volumio sudo[9618]: pam_unix(sudo:session): session closed for user root May 23 17:47:20 volumio sudo[9623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 23 17:47:20 volumio sudo[9623]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 17:47:20 volumio volumio[1047]: info: MPD Permissions set May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 17:47:20 volumio systemd[1]: Stopping Music Player Daemon... May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 23 17:47:20 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 17:47:20 volumio systemd[1]: mpd.service: Succeeded. May 23 17:47:20 volumio systemd[1]: Stopped Music Player Daemon. May 23 17:47:20 volumio systemd[1]: Starting Music Player Daemon... May 23 17:47:20 volumio sudo[9631]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 23 17:47:20 volumio sudo[9631]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 17:47:20 volumio sudo[9631]: pam_unix(sudo:session): session closed for user root May 23 17:47:20 volumio mpd[9633]: May 23 17:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 23 17:47:20 volumio systemd[1]: Started Music Player Daemon. May 23 17:47:20 volumio sudo[9623]: pam_unix(sudo:session): session closed for user root May 23 17:47:20 volumio volumio[1047]: error: updateQueue error: null May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 23 17:47:23 volumio volumio[1047]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 23 17:47:23 volumio volumio[1047]: info: Received Get System Version May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 17:47:23 volumio volumio[1047]: info: Received Get System Info May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 17:47:23 volumio volumio[1047]: info: Discovery: Getting this device information May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 17:47:25 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:27 volumio volumio[1047]: info: Retrieving Cloud Streaming UI May 23 17:47:27 volumio volumio[1047]: info: Getting Tidal Cloud Configuration May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:27 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration May 23 17:47:27 volumio volumio[1047]: info: Asking plugin for UI Config May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:27 volumio volumio[1047]: info: Getting Spotify Cloud Configuration May 23 17:47:27 volumio volumio[1047]: info: Asking plugin for UI Config May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:27 volumio volumio[1047]: info: Saving Spotify Acccount May 23 17:47:27 volumio volumio[1047]: info: Got Tidal Cloud Configuration May 23 17:47:27 volumio volumio[1047]: info: Got it May 23 17:47:27 volumio volumio[1047]: info: Got it May 23 17:47:27 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin May 23 17:47:27 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::volumioGetBrowseSources May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::volumioGetBrowseSources May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::volumioGetBrowseSources May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 23 17:47:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 23 17:47:31 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 23 17:47:32 volumio volumio[1047]: info: Disabling MyMusic plugin upnp May 23 17:47:32 volumio sudo[9666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 23 17:47:32 volumio sudo[9666]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 17:47:32 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... May 23 17:47:32 volumio volumio[1047]: error: Upnp client error: Error: This socket has been ended by the other party May 23 17:47:33 volumio volumio[1047]: info: Enabling MyMusic plugin upnp May 23 17:47:33 volumio volumio[1047]: info: Enabling plugin upnp May 23 17:47:33 volumio volumio[1047]: info: Loading plugin "upnp"... May 23 17:47:33 volumio volumio[1047]: info: [1748015253665] Starting Upmpd Daemon May 23 17:47:33 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 23 17:47:33 volumio volumio[1047]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 17:47:33 volumio volumio[1047]: Error: listen EADDRINUSE: address already in use :::6599 May 23 17:47:33 volumio volumio[1047]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) May 23 17:47:33 volumio volumio[1047]: at listenInCluster (net.js:1379:12) May 23 17:47:33 volumio volumio[1047]: at Server.listen (net.js:1465:7) May 23 17:47:33 volumio volumio[1047]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 23 17:47:33 volumio volumio[1047]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 23 17:47:33 volumio volumio[1047]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 23 17:47:33 volumio volumio[1047]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 23 17:47:33 volumio volumio[1047]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { May 23 17:47:33 volumio volumio[1047]: code: 'EADDRINUSE', May 23 17:47:33 volumio volumio[1047]: errno: -98, May 23 17:47:33 volumio volumio[1047]: syscall: 'listen', May 23 17:47:33 volumio volumio[1047]: address: '::', May 23 17:47:33 volumio volumio[1047]: port: 6599 May 23 17:47:33 volumio volumio[1047]: } May 23 17:47:33 volumio volumio[1047]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 17:47:33 volumio sudo[9677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-23 17:46 May 23 17:47:33 volumio sudo[9677]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"