Dec 21 12:05:04 volumio sudo[12000]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 21 12:05:04 volumio sudo[12000]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 21 12:05:04 volumio sudo[12000]: pam_unix(sudo:session): session closed for user root
Dec 21 12:05:04 volumio sudo[12002]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 21 12:05:04 volumio sudo[12002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 21 12:05:04 volumio sudo[12002]: pam_unix(sudo:session): session closed for user root
Dec 21 12:05:04 volumio volumio[1248]: verbose: New Socket.io Connection to 192.168.8.163 from 192.168.8.166 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Dec 21 12:05:04 volumio sudo[12006]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 21 12:05:04 volumio sudo[12006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 21 12:05:04 volumio sudo[12006]: pam_unix(sudo:session): session closed for user root
Dec 21 12:05:04 volumio sudo[12008]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 21 12:05:04 volumio sudo[12008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 21 12:05:04 volumio sudo[12008]: pam_unix(sudo:session): session closed for user root
Dec 21 12:05:04 volumio volumio[1248]: verbose: New Socket.io Connection to 192.168.8.163 from 192.168.8.166 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 21 12:05:04 volumio volumio[1248]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 21 12:05:04 volumio volumio[1248]: info: Received Get System Info
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 21 12:05:04 volumio volumio[1248]: info: Discovery: Getting this device information
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:04 volumio volumio[1248]: info: Listing playlists
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 21 12:05:04 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 21 12:05:05 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 21 12:05:06 volumio volumio[1248]: info: Received Get System Info
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 21 12:05:06 volumio volumio[1248]: info: Discovery: Getting this device information
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 21 12:05:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 21 12:05:07 volumio volumio[1248]: info: Executing endpoint metavolumio
Dec 21 12:05:07 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 21 12:05:07 volumio volumio[1248]: info: Executing endpoint metavolumio
Dec 21 12:05:07 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 21 12:05:07 volumio volumio[1248]: info: Executing endpoint metavolumio
Dec 21 12:05:07 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 21 12:05:10 volumio volumio[1248]: info: Received Get System Info
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 21 12:05:10 volumio volumio[1248]: info: Discovery: Getting this device information
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 21 12:05:10 volumio volumio[1248]: info: Received Get System Info
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 21 12:05:10 volumio volumio[1248]: info: Discovery: Getting this device information
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 21 12:05:14 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 21 12:05:21 volumio volumio[1248]: info: Retrieving Cloud Streaming UI
Dec 21 12:05:21 volumio volumio[1248]: info: Getting Tidal Cloud Configuration
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 21 12:05:21 volumio volumio[1248]: info: Getting Qobuz Cloud Configuration
Dec 21 12:05:21 volumio volumio[1248]: info: Asking plugin for UI Config
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 21 12:05:21 volumio volumio[1248]: info: Getting Spotify Cloud Configuration
Dec 21 12:05:21 volumio volumio[1248]: info: Asking plugin for UI Config
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 21 12:05:21 volumio volumio[1248]: info: Saving Spotify Acccount
Dec 21 12:05:21 volumio volumio[1248]: info: Got it
Dec 21 12:05:21 volumio volumio[1248]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 21 12:05:21 volumio volumio[1248]: info: Got Tidal Cloud Configuration
Dec 21 12:05:21 volumio volumio[1248]: info: Got it
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:21 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 21 12:05:23 volumio volumio[1248]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Dec 21 12:05:23 volumio volumio[1248]: info: Received Get System Version
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 21 12:05:23 volumio volumio[1248]: info: Received Get System Info
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 21 12:05:23 volumio volumio[1248]: info: Discovery: Getting this device information
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState
Dec 21 12:05:23 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 21 12:05:25 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:27 volumio go-librespot[1629]: time="2025-12-21T12:05:27+04:00" level=trace msg="received accesspoint ping"
Dec 21 12:05:28 volumio go-librespot[1629]: time="2025-12-21T12:05:28+04:00" level=trace msg="received accesspoint pong ack"
Dec 21 12:05:28 volumio go-librespot[1629]: time="2025-12-21T12:05:28+04:00" level=trace msg="sent dealer ping"
Dec 21 12:05:29 volumio go-librespot[1629]: time="2025-12-21T12:05:29+04:00" level=trace msg="received dealer pong"
Dec 21 12:05:29 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:33 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:37 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:41 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:45 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:49 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:53 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:57 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:05:58 volumio go-librespot[1629]: time="2025-12-21T12:05:58+04:00" level=trace msg="sent dealer ping"
Dec 21 12:05:59 volumio go-librespot[1629]: time="2025-12-21T12:05:59+04:00" level=trace msg="received dealer pong"
Dec 21 12:06:01 volumio volumio[1248]: info: Disabling MyMusic plugin upnp
Dec 21 12:06:01 volumio sudo[12330]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Dec 21 12:06:01 volumio sudo[12330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 21 12:06:01 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Dec 21 12:06:01 volumio systemd[1]: Stopping upmpdcli.service - UPnP Renderer front-end to MPD...
Dec 21 12:06:01 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 21 12:06:02 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Dec 21 12:06:02 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Dec 21 12:06:03 volumio volumio[1248]: info: Enabling MyMusic plugin upnp
Dec 21 12:06:03 volumio volumio[1248]: info: Enabling plugin upnp
Dec 21 12:06:03 volumio volumio[1248]: info: Loading plugin "upnp"...
Dec 21 12:06:03 volumio volumio[1248]: info: [1766304363210] Starting Upmpd Daemon
Dec 21 12:06:03 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 21 12:06:03 volumio volumio[1248]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 21 12:06:03 volumio volumio[1248]: Error: listen EADDRINUSE: address already in use :::6599
Dec 21 12:06:03 volumio volumio[1248]: at Server.setupListenHandle [as _listen2] (node:net:1872:16)
Dec 21 12:06:03 volumio volumio[1248]: at listenInCluster (node:net:1920:12)
Dec 21 12:06:03 volumio volumio[1248]: at Server.listen (node:net:2008:7)
Dec 21 12:06:03 volumio volumio[1248]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Dec 21 12:06:03 volumio volumio[1248]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Dec 21 12:06:03 volumio volumio[1248]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Dec 21 12:06:03 volumio volumio[1248]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Dec 21 12:06:03 volumio volumio[1248]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) {
Dec 21 12:06:03 volumio volumio[1248]: code: 'EADDRINUSE',
Dec 21 12:06:03 volumio volumio[1248]: errno: -98,
Dec 21 12:06:03 volumio volumio[1248]: syscall: 'listen',
Dec 21 12:06:03 volumio volumio[1248]: address: '::',
Dec 21 12:06:03 volumio volumio[1248]: port: 6599
Dec 21 12:06:03 volumio volumio[1248]: }
Dec 21 12:06:03 volumio volumio[1248]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 21 12:06:03 volumio sudo[12372]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-21 12:05'
Dec 21 12:06:03 volumio sudo[12372]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"