Jul 07 13:40:21 volumio volumio[1077]: verbose: New Socket.io Connection to volumio.local from 10.100.1.175 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jul 07 13:40:21 volumio volumio[1077]: info: CoreCommandRouter::volumioGetState Jul 07 13:40:21 volumio volumio[1077]: info: CoreCommandRouter::volumioGetQueue Jul 07 13:40:21 volumio volumio[1077]: info: CoreStateMachine::getQueue Jul 07 13:40:21 volumio volumio[1077]: info: CorePlayQueue::getQueue Jul 07 13:40:21 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Jul 07 13:40:21 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Jul 07 13:40:21 volumio volumio[1077]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Jul 07 13:40:21 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Jul 07 13:40:21 volumio volumio[1077]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Jul 07 13:40:21 volumio volumio[1077]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Jul 07 13:40:21 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Jul 07 13:40:25 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setUpdaterChannel Jul 07 13:40:25 volumio volumio[1077]: info: Updater channel set to test Jul 07 13:40:27 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:27 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:27 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:30 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:30 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:30 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:31 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:31 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:31 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:31 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:31 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:31 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:31 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:31 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:31 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:31 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:31 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:31 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:32 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:32 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:32 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:32 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:32 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:32 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:32 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:32 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:32 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:32 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:32 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:32 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:33 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:33 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:33 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:33 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:33 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:33 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:33 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:33 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:33 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:33 volumio volumio[1077]: info: CALLMETHOD: system_controller system setTestPlugins true Jul 07 13:40:33 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Jul 07 13:40:33 volumio volumio[1077]: info: Plugins store is now in test mode Jul 07 13:40:51 volumio sudo[12146]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 13:40:51 volumio sudo[12146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 07 13:40:51 volumio sudo[12146]: pam_unix(sudo:session): session closed for user root Jul 07 13:40:51 volumio sudo[12148]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 13:40:51 volumio sudo[12148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 07 13:40:51 volumio sudo[12148]: pam_unix(sudo:session): session closed for user root Jul 07 13:40:51 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 07 13:40:51 volumio sudo[12155]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 13:40:51 volumio sudo[12155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 07 13:40:51 volumio sudo[12157]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 13:40:51 volumio sudo[12157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 07 13:40:51 volumio sudo[12155]: pam_unix(sudo:session): session closed for user root Jul 07 13:40:51 volumio dbus-daemon[742]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.82' (uid=0 pid=12158 comm="timedatectl show --property=NTPSynchronized --valu") Jul 07 13:40:51 volumio sudo[12157]: pam_unix(sudo:session): session closed for user root Jul 07 13:40:51 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 07 13:40:51 volumio volumio[1077]: verbose: New Socket.io Connection to 10.100.1.229 from 10.100.1.175 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jul 07 13:40:51 volumio dbus-daemon[742]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 07 13:40:51 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 07 13:40:51 volumio setdatetime-helper.sh[12150]: Time is already synchronized. Jul 07 13:40:51 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 07 13:40:51 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::volumioGetState Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::volumioGetQueue Jul 07 13:40:51 volumio volumio[1077]: info: CoreStateMachine::getQueue Jul 07 13:40:51 volumio volumio[1077]: info: CorePlayQueue::getQueue Jul 07 13:40:51 volumio volumio[1077]: info: Listing playlists Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 07 13:40:51 volumio volumio[1077]: info: Received Get System Info Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 13:40:51 volumio volumio[1077]: info: Discovery: Getting this device information Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::volumioGetState Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::volumioGetState Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 07 13:40:51 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 07 13:40:53 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 07 13:40:53 volumio volumio[1077]: info: Received Get System Info Jul 07 13:40:53 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 13:40:53 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 13:40:53 volumio volumio[1077]: info: Discovery: Getting this device information Jul 07 13:40:53 volumio volumio[1077]: info: CoreCommandRouter::volumioGetState Jul 07 13:40:53 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 13:40:53 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 07 13:40:57 volumio volumio[1077]: info: CoreCommandRouter::volumioGetState Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 13:40:58 volumio volumio[1077]: info: Retrieving Cloud Streaming UI Jul 07 13:40:58 volumio volumio[1077]: info: Getting Tidal Cloud Configuration Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 13:40:58 volumio volumio[1077]: info: Getting Qobuz Cloud Configuration Jul 07 13:40:58 volumio volumio[1077]: info: Asking plugin for UI Config Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 13:40:58 volumio volumio[1077]: info: Getting Spotify Cloud Configuration Jul 07 13:40:58 volumio volumio[1077]: info: Asking plugin for UI Config Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 13:40:58 volumio volumio[1077]: info: Saving Spotify Acccount Jul 07 13:40:58 volumio volumio[1077]: info: Got Tidal Cloud Configuration Jul 07 13:40:58 volumio volumio[1077]: info: Got it Jul 07 13:40:58 volumio volumio[1077]: info: Got it Jul 07 13:40:58 volumio volumio[1077]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 13:40:58 volumio volumio[1077]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 13:40:58 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 07 13:41:01 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 13:41:02 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 13:41:04 volumio volumio[1077]: info: Disabling MyMusic plugin upnp Jul 07 13:41:04 volumio sudo[12217]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 07 13:41:04 volumio sudo[12217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 07 13:41:04 volumio systemd[1]: Stopping upmpdcli.service - UPnP Renderer front-end to MPD... Jul 07 13:41:06 volumio volumio[1077]: info: Enabling MyMusic plugin upnp Jul 07 13:41:06 volumio volumio[1077]: info: Enabling plugin upnp Jul 07 13:41:06 volumio volumio[1077]: info: Loading plugin "upnp"... Jul 07 13:41:06 volumio volumio[1077]: info: [1751870466051] Starting Upmpd Daemon Jul 07 13:41:06 volumio volumio[1077]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 13:41:06 volumio volumio[1077]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 13:41:06 volumio volumio[1077]: Error: listen EADDRINUSE: address already in use :::6599 Jul 07 13:41:06 volumio volumio[1077]: at Server.setupListenHandle [as _listen2] (node:net:1872:16) Jul 07 13:41:06 volumio volumio[1077]: at listenInCluster (node:net:1920:12) Jul 07 13:41:06 volumio volumio[1077]: at Server.listen (node:net:2008:7) Jul 07 13:41:06 volumio volumio[1077]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jul 07 13:41:06 volumio volumio[1077]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jul 07 13:41:06 volumio volumio[1077]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jul 07 13:41:06 volumio volumio[1077]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 07 13:41:06 volumio volumio[1077]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Jul 07 13:41:06 volumio volumio[1077]: code: 'EADDRINUSE', Jul 07 13:41:06 volumio volumio[1077]: errno: -98, Jul 07 13:41:06 volumio volumio[1077]: syscall: 'listen', Jul 07 13:41:06 volumio volumio[1077]: address: '::', Jul 07 13:41:06 volumio volumio[1077]: port: 6599 Jul 07 13:41:06 volumio volumio[1077]: } Jul 07 13:41:06 volumio volumio[1077]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 13:41:06 volumio sudo[12237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-07 13:40' Jul 07 13:41:06 volumio sudo[12237]: 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="4f980d5cf693b4272997a2fa2da8bb8036ddf1ab" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jul 5 02:50:33 UTC 2025" VOLUMIO_VERSION="4.015" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d42ab79cc13d24482826e04fda2e8350"