Dec 11 20:15:03 volumio volumio[1088]: info: CoreCommandRouter::volumioPlay
Dec 11 20:15:03 volumio volumio[1088]: info: CoreStateMachine::play index undefined
Dec 11 20:15:03 volumio volumio[1088]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 11 20:15:03 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 11 20:15:09 volumio volumio[1088]: info: Retrieving Cloud Streaming UI
Dec 11 20:15:09 volumio volumio[1088]: info: Getting Tidal Cloud Configuration
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 11 20:15:09 volumio volumio[1088]: info: Getting Qobuz Cloud Configuration
Dec 11 20:15:09 volumio volumio[1088]: info: Asking plugin for UI Config
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 11 20:15:09 volumio volumio[1088]: info: Getting Spotify Cloud Configuration
Dec 11 20:15:09 volumio volumio[1088]: info: Asking plugin for UI Config
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 11 20:15:09 volumio volumio[1088]: info: Saving Spotify Acccount
Dec 11 20:15:09 volumio volumio[1088]: info: Got Tidal Cloud Configuration
Dec 11 20:15:09 volumio volumio[1088]: info: Got it
Dec 11 20:15:09 volumio volumio[1088]: info: Got it
Dec 11 20:15:09 volumio volumio[1088]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 11 20:15:09 volumio volumio[1088]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 11 20:15:13 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:17 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:19 volumio volumio[1088]: info: Enabling MyMusic plugin multiroom
Dec 11 20:15:19 volumio volumio[1088]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface multiroom
Dec 11 20:15:19 volumio volumio[1088]: info: [MyVolumio PluginManager] Plugin audio_interface multiroom not in user plan, not enabling
Dec 11 20:15:19 volumio volumio[1088]: info: Error: Plugin audio_interface multiroom not in user plan, not enabling
Dec 11 20:15:19 volumio volumio[1088]: error: Could not Enable MyMusic Plugin: Error
Dec 11 20:15:21 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:24 volumio volumio[1088]: info: Enabling MyMusic plugin smart_inputs
Dec 11 20:15:24 volumio volumio[1088]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs
Dec 11 20:15:24 volumio volumio[1088]: info: [MyVolumio PluginManager] Plugin music_service smart_inputs not in user plan, not enabling
Dec 11 20:15:24 volumio volumio[1088]: info: Error: Plugin music_service smart_inputs not in user plan, not enabling
Dec 11 20:15:24 volumio volumio[1088]: error: Could not Enable MyMusic Plugin: Error
Dec 11 20:15:25 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:27 volumio volumio[1088]: info: Enabling MyMusic plugin bluetooth
Dec 11 20:15:27 volumio volumio[1088]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth
Dec 11 20:15:27 volumio volumio[1088]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling
Dec 11 20:15:27 volumio volumio[1088]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling
Dec 11 20:15:27 volumio volumio[1088]: error: Could not Enable MyMusic Plugin: Error
Dec 11 20:15:29 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:33 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand update
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: info:
Dec 11 20:15:36 volumio volumio[1088]: ---------------------------- MPD announces state update: update
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand update took 1 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::getState
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: info:
Dec 11 20:15:36 volumio volumio[1088]: ---------------------------- MPD announces state update: update
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::getState
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 1 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 0 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 0 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 1 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: info: Command Router : Notfying DB Updatetrue
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: info: Command Router : Notfying DB Updatetrue
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::Close All Modals sent
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::servicePushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 11 20:15:36 volumio volumio[1088]: verbose: CURRENT POSITION 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState stateService stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: No code
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::servicePushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 11 20:15:36 volumio volumio[1088]: verbose: CURRENT POSITION 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState stateService stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: No code
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: ------------------------------ 78ms
Dec 11 20:15:36 volumio volumio[1088]: info: ------------------------------ 81ms
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: info:
Dec 11 20:15:36 volumio volumio[1088]: ---------------------------- MPD announces state update: update
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::getState
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: info:
Dec 11 20:15:36 volumio volumio[1088]: ---------------------------- MPD announces state update: update
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::getState
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 11 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 11 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 11 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: info: sendMpdCommand status took 11 milliseconds
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: info: Command Router : Notfying DB Updatefalse
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::Close All Modals sent
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: info: Command Router : Notfying DB Updatefalse
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::Close All Modals sent
Dec 11 20:15:36 volumio volumio[1088]: verbose: ControllerMpd::parseState
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::servicePushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 11 20:15:36 volumio volumio[1088]: verbose: CURRENT POSITION 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState stateService stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: No code
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: ControllerMpd::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::servicePushState
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 11 20:15:36 volumio volumio[1088]: verbose: CURRENT POSITION 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState stateService stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus stop
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: No code
Dec 11 20:15:36 volumio volumio[1088]: info: CoreStateMachine::pushState
Dec 11 20:15:36 volumio volumio[1088]: info: CorePlayQueue::getTrack 0
Dec 11 20:15:36 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState
Dec 11 20:15:36 volumio volumio[1088]: info: ------------------------------ 58ms
Dec 11 20:15:36 volumio volumio[1088]: info: ------------------------------ 58ms
Dec 11 20:15:37 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:38 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Dec 11 20:15:38 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Dec 11 20:15:41 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:45 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:49 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:53 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:15:57 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:16:01 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:16:05 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare
Dec 11 20:16:05 volumio volumio[1088]: info: Adding a new share
Dec 11 20:16:05 volumio volumio[1088]: info: Share alias is blank
Dec 11 20:16:05 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 11 20:16:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Dec 11 20:16:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Dec 11 20:16:09 volumio volumio[1088]: compat.c: read() failed: Resource temporarily unavailable
Dec 11 20:16:09 volumio volumio[1088]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 11 20:16:09 volumio volumio[1088]: Error: dns service error: unknown
Dec 11 20:16:09 volumio volumio[1088]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Dec 11 20:16:09 volumio volumio[1088]: errorCode: -65537
Dec 11 20:16:09 volumio volumio[1088]: }
Dec 11 20:16:09 volumio volumio[1088]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 11 20:16:09 volumio sudo[3154]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-11 20:15'
Dec 11 20:16:09 volumio sudo[3154]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"