Oct 02 13:49:00 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 02 13:49:00 volumio volumio[1362]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 02 13:49:00 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:00 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:49:05 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 02 13:49:22 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:22 volumio volumio[1362]: info: Retrieving Cloud Streaming UI Oct 02 13:49:22 volumio volumio[1362]: info: Getting Tidal Cloud Configuration Oct 02 13:49:22 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:22 volumio volumio[1362]: info: Getting Qobuz Cloud Configuration Oct 02 13:49:22 volumio volumio[1362]: info: Asking plugin for UI Config Oct 02 13:49:22 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:22 volumio volumio[1362]: info: Getting Spotify Cloud Configuration Oct 02 13:49:22 volumio volumio[1362]: info: Asking plugin for UI Config Oct 02 13:49:22 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:22 volumio volumio[1362]: info: Saving Spotify Acccount Oct 02 13:49:22 volumio volumio[1362]: info: Got Tidal Cloud Configuration Oct 02 13:49:22 volumio volumio[1362]: info: Got it Oct 02 13:49:22 volumio volumio[1362]: info: Got it Oct 02 13:49:22 volumio volumio[1362]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 02 13:49:22 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:22 volumio volumio[1362]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Oct 02 13:49:27 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Oct 02 13:49:27 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 02 13:49:27 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Oct 02 13:49:27 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Oct 02 13:49:27 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::Reload Ui Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Oct 02 13:49:30 volumio volumio[1362]: info: Wizard terminated Successfully Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::volumiosetStartupVolume Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 13:49:30 volumio volumio5-onboarding[2052]: time=2026-10-02T06:49:30.113Z level=INFO msg="emitting device setup status changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" setupComplete=true Oct 02 13:49:30 volumio volumio[1362]: info: Received Get System Info Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 13:49:30 volumio volumio[1362]: info: Discovery: Getting this device information Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:30 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 02 13:49:30 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 02 13:49:30 volumio volumio5-onboarding[2052]: time=2026-10-02T06:49:30.896Z level=INFO msg="service successfully established" component=discovery/localnet Oct 02 13:49:31 volumio volumio[1362]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 02 13:49:33 volumio volumio[1362]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:33 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 02 13:49:33 volumio volumio[1362]: info: Received Get System Info Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 13:49:33 volumio volumio[1362]: info: Discovery: Getting this device information Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:33 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:33 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:33 volumio volumio[1362]: info: Listing playlists Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 02 13:49:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 02 13:49:34 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 02 13:49:34 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:34 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:35 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 02 13:49:35 volumio volumio[1362]: info: Received Get System Info Oct 02 13:49:35 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 13:49:35 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 13:49:35 volumio volumio[1362]: info: Discovery: Getting this device information Oct 02 13:49:35 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:49:35 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:49:35 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 13:49:35 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 02 13:49:43 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 02 13:49:52 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:54 volumio volumio[1362]: info: Retrieving Cloud Streaming UI Oct 02 13:49:54 volumio volumio[1362]: info: Getting Tidal Cloud Configuration Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:54 volumio volumio[1362]: info: Getting Qobuz Cloud Configuration Oct 02 13:49:54 volumio volumio[1362]: info: Asking plugin for UI Config Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:54 volumio volumio[1362]: info: Getting Spotify Cloud Configuration Oct 02 13:49:54 volumio volumio[1362]: info: Asking plugin for UI Config Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:54 volumio volumio[1362]: info: Saving Spotify Acccount Oct 02 13:49:54 volumio volumio[1362]: info: Got Tidal Cloud Configuration Oct 02 13:49:54 volumio volumio[1362]: info: Got it Oct 02 13:49:54 volumio volumio[1362]: info: Got it Oct 02 13:49:54 volumio volumio[1362]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:49:54 volumio volumio[1362]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:49:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 02 13:49:56 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 02 13:49:56 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand update Oct 02 13:49:56 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:49:56 volumio volumio[1362]: info: Oct 02 13:49:56 volumio volumio[1362]: ---------------------------- MPD announces state update: update Oct 02 13:49:56 volumio volumio[1362]: info: sendMpdCommand update took 2 milliseconds Oct 02 13:49:56 volumio volumio[1362]: info: ControllerMpd::getState Oct 02 13:49:56 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:49:56 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:49:56 volumio volumio[1362]: info: Oct 02 13:49:56 volumio volumio[1362]: ---------------------------- MPD announces state update: update Oct 02 13:49:56 volumio volumio[1362]: info: ControllerMpd::getState Oct 02 13:49:56 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:49:56 volumio volumio[1362]: info: sendMpdCommand status took 5 milliseconds Oct 02 13:49:56 volumio volumio[1362]: info: sendMpdCommand status took 5 milliseconds Oct 02 13:49:56 volumio volumio[1362]: info: sendMpdCommand status took 5 milliseconds Oct 02 13:49:56 volumio volumio[1362]: info: sendMpdCommand status took 4 milliseconds Oct 02 13:49:56 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:14 volumio volumio[1362]: info: Command Router : Notfying DB Updatetrue Oct 02 13:50:14 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:14 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio[1362]: info: Command Router : Notfying DB Updatetrue Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::servicePushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: 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} Oct 02 13:50:15 volumio volumio[1362]: verbose: CURRENT POSITION 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState stateService stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: No code Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::servicePushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: 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} Oct 02 13:50:15 volumio volumio[1362]: verbose: CURRENT POSITION 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState stateService stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: No code Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.505Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.505Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.506Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.506Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.506Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.507Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio[1362]: info: ------------------------------ 18726ms Oct 02 13:50:15 volumio volumio[1362]: info: ------------------------------ 18725ms Oct 02 13:50:15 volumio volumio[1362]: info: MPD Database updated - AlbumList cache refreshed Oct 02 13:50:15 volumio volumio[1362]: info: Oct 02 13:50:15 volumio volumio[1362]: ---------------------------- MPD announces state update: database Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:50:15 volumio volumio[1362]: info: Oct 02 13:50:15 volumio volumio[1362]: ---------------------------- MPD announces state update: update Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::getState Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::getState Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:50:15 volumio volumio[1362]: info: MPD Database updated - AlbumList cache refreshed Oct 02 13:50:15 volumio volumio[1362]: info: Oct 02 13:50:15 volumio volumio[1362]: ---------------------------- MPD announces state update: database Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:50:15 volumio volumio[1362]: info: Oct 02 13:50:15 volumio volumio[1362]: ---------------------------- MPD announces state update: update Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::getState Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::getState Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.589Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:15 volumio volumio[1362]: info: sendMpdCommand status took 86 milliseconds Oct 02 13:50:15 volumio volumio[1362]: info: sendMpdCommand status took 87 milliseconds Oct 02 13:50:15 volumio volumio[1362]: info: sendMpdCommand status took 87 milliseconds Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.648Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:15 volumio volumio[1362]: info: Command Router : Notfying DB Updatefalse Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.707Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::servicePushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: 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} Oct 02 13:50:15 volumio volumio[1362]: verbose: CURRENT POSITION 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState stateService stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: No code Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::servicePushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: 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} Oct 02 13:50:15 volumio volumio[1362]: verbose: CURRENT POSITION 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState stateService stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: No code Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.722Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.722Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.722Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.723Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.723Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.723Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio[1362]: info: ------------------------------ 214ms Oct 02 13:50:15 volumio volumio[1362]: info: ------------------------------ 213ms Oct 02 13:50:15 volumio volumio[1362]: info: sendMpdCommand status took 250 milliseconds Oct 02 13:50:15 volumio volumio[1362]: info: sendMpdCommand status took 249 milliseconds Oct 02 13:50:15 volumio volumio[1362]: info: sendMpdCommand status took 249 milliseconds Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.767Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:15 volumio volumio[1362]: info: Command Router : Notfying DB Updatefalse Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio[1362]: verbose: ControllerMpd::parseState Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::servicePushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: 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} Oct 02 13:50:15 volumio volumio[1362]: verbose: CURRENT POSITION 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState stateService stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: No code Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: ControllerMpd::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::servicePushState Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: 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} Oct 02 13:50:15 volumio volumio[1362]: verbose: CURRENT POSITION 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState stateService stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio[1362]: info: No code Oct 02 13:50:15 volumio volumio[1362]: info: CoreStateMachine::pushState Oct 02 13:50:15 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:15 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.787Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.791Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.791Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.791Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.791Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.791Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" state=STATUS_STOPPED positionMs=0 volume=100 Oct 02 13:50:15 volumio volumio[1362]: info: ------------------------------ 279ms Oct 02 13:50:15 volumio volumio[1362]: info: ------------------------------ 279ms Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.828Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:15 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:15.892Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.128Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.192Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.248Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.308Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.367Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.432Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.551Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.608Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.668Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.728Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.792Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:16 volumio volumio5-onboarding[2052]: time=2026-10-02T06:50:16.848Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0xc00052c210" id= title= Oct 02 13:50:18 volumio volumio[1362]: info: CoreCommandRouter::volumioGetQueue Oct 02 13:50:18 volumio volumio[1362]: info: CoreStateMachine::getQueue Oct 02 13:50:18 volumio volumio[1362]: info: CorePlayQueue::getQueue Oct 02 13:50:19 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:50:19 volumio volumio[1362]: info: CURURI: music-library Oct 02 13:50:20 volumio volumio[1362]: info: Preload queue cleared Oct 02 13:50:20 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:50:20 volumio volumio[1362]: info: CURURI: music-library/INTERNAL Oct 02 13:50:21 volumio volumio[1362]: info: Preload queue cleared Oct 02 13:50:21 volumio volumio[1362]: info: Preloading song: music-library/INTERNAL/Depeche Mode - Home.wav Oct 02 13:50:21 volumio volumio[1362]: info: Preloading song: music-library/INTERNAL/Raye – Regardless.flac Oct 02 13:50:21 volumio volumio[1362]: info: Preloading song: music-library/INTERNAL/Depeche Mode – Everything Counts (Original 7 Inch Mix).flac Oct 02 13:50:21 volumio volumio[1362]: info: Preloading song: music-library/INTERNAL/Elton John – Blessed.flac Oct 02 13:50:21 volumio volumio[1362]: info: Preloading song: music-library/INTERNAL/11. Money For Nothing.flac Oct 02 13:50:21 volumio volumio[1362]: info: Preloading song: music-library/INTERNAL/Peter and the Roses – Night Road.flac Oct 02 13:50:21 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Depeche Mode - Home.wav in service mpd Oct 02 13:50:21 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Raye – Regardless.flac in service mpd Oct 02 13:50:21 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Depeche Mode – Everything Counts (Original 7 Inch Mix).flac in service mpd Oct 02 13:50:21 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Elton John – Blessed.flac in service mpd Oct 02 13:50:21 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/11. Money For Nothing.flac in service mpd Oct 02 13:50:21 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Peter and the Roses – Night Road.flac in service mpd Oct 02 13:50:21 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=//extralarge&path=%2Fmnt%2FINTERNAL%2FDepeche%20Mode%20-%20Home.wav&metadata=false Oct 02 13:50:21 volumio volumio[1362]: info: URI /mnt/INTERNAL/Depeche Mode - Home.wav Oct 02 13:50:21 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=Raye/Euphoric%20Sad%20Songs/extralarge&path=%2Fmnt%2FINTERNAL%2FRaye%20%E2%80%93%20Regardless.flac&metadata=false Oct 02 13:50:21 volumio volumio[1362]: info: URI /mnt/INTERNAL/Raye – Regardless.flac Oct 02 13:50:21 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=Depeche%20Mode/Everything%20Counts%20And%20Live%20Tracks/extralarge&path=%2Fmnt%2FINTERNAL%2FDepeche%20Mode%20%E2%80%93%20Everything%20Counts%20(Original%207%20Inch%20Mix).flac&metadata=false Oct 02 13:50:21 volumio volumio[1362]: info: URI /mnt/INTERNAL/Depeche Mode – Everything Counts (Original 7 Inch Mix).flac Oct 02 13:50:21 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=Elton%20John/Made%20In%20England/extralarge&path=%2Fmnt%2FINTERNAL%2FElton%20John%20%E2%80%93%20Blessed.flac&metadata=false Oct 02 13:50:21 volumio volumio[1362]: info: URI /mnt/INTERNAL/Elton John – Blessed.flac Oct 02 13:50:21 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=Dire%20Straits/Money%20For%20Nothing/extralarge&path=%2Fmnt%2FINTERNAL%2F11.%20Money%20For%20Nothing.flac&metadata=false Oct 02 13:50:21 volumio volumio[1362]: info: URI /mnt/INTERNAL/11. Money For Nothing.flac Oct 02 13:50:21 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=Peter%20and%20the%20Roses/Peter%20and%20the%20Roses/extralarge&path=%2Fmnt%2FINTERNAL%2FPeter%20and%20the%20Roses%20%E2%80%93%20Night%20Road.flac&metadata=false Oct 02 13:50:21 volumio volumio[1362]: info: URI /mnt/INTERNAL/Peter and the Roses – Night Road.flac Oct 02 13:50:22 volumio volumio[1362]: info: Preload queue cleared Oct 02 13:50:22 volumio volumio[1362]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::ClearQueue Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::stop Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::clearPlayQueue Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::saveQueue Oct 02 13:50:22 volumio volumio[1362]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::addQueueItems Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::addQueueItems Oct 02 13:50:22 volumio volumio[1362]: info: Preload queue cleared Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Depeche Mode - Home.wav Oct 02 13:50:22 volumio volumio[1362]: info: Using cached record of: music-library/INTERNAL/Depeche Mode - Home.wav Oct 02 13:50:22 volumio volumio[1362]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::saveQueue Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::updateTrackBlock Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::getTrackBlock Oct 02 13:50:22 volumio volumio[1362]: info: CoreCommandRouter::volumioPlay Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::play index 0 Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::addQueueItems Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::addQueueItems Oct 02 13:50:22 volumio volumio[1362]: info: Preload queue cleared Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Raye – Regardless.flac Oct 02 13:50:22 volumio volumio[1362]: info: Using cached record of: music-library/INTERNAL/Raye – Regardless.flac Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Depeche Mode – Everything Counts (Original 7 Inch Mix).flac Oct 02 13:50:22 volumio volumio[1362]: info: Using cached record of: music-library/INTERNAL/Depeche Mode – Everything Counts (Original 7 Inch Mix).flac Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Elton John – Blessed.flac Oct 02 13:50:22 volumio volumio[1362]: info: Using cached record of: music-library/INTERNAL/Elton John – Blessed.flac Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/11. Money For Nothing.flac Oct 02 13:50:22 volumio volumio[1362]: info: Using cached record of: music-library/INTERNAL/11. Money For Nothing.flac Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Peter and the Roses – Night Road.flac Oct 02 13:50:22 volumio volumio[1362]: info: Using cached record of: music-library/INTERNAL/Peter and the Roses – Night Road.flac Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/A-Ha Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/A-Ha in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Adele Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Adele in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Alphaville Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Alphaville in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Black Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Black in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Blue Coast Collection Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Blue Coast Collection in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Enigma - (1990) - MCMXC a.D. [SACD] Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Enigma - (1990) - MCMXC a.D. [SACD] in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Frank Duval Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Frank Duval in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Joe Dassin - Eternel... (2005, Re2023, France, 2LP, DST128) Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Joe Dassin - Eternel... (2005, Re2023, France, 2LP, DST128) in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Master Superior Audiophile 2020 [DSF] Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Master Superior Audiophile 2020 [DSF] in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Metallica - 72 Seasons (2023, EU) Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Metallica - 72 Seasons (2023, EU) in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/NEW Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/NEW in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Pink Floyd - Delicate Sound Of Thunder -2020 DSD Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Pink Floyd - Delicate Sound Of Thunder -2020 DSD in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Pink_Floyd_-_The_Dark_Side_Of_The_Moon_50th_Anniversary__2023 Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Pink_Floyd_-_The_Dark_Side_Of_The_Moon_50th_Anniversary__2023 in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Pink_Floyd_at_Pompeii_-_MCMLXXII_2025 Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Pink_Floyd_at_Pompeii_-_MCMLXXII_2025 in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Planet of Rhythm Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Planet of Rhythm in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Polarity - An Acoustic Jazz Project Stereo Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Polarity - An Acoustic Jazz Project Stereo in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Richard Clayderman ‎– The Music Of Love- 1984,(UK),DSF(tracks),(ART-9s+NG-5rd+Tang) Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Richard Clayderman ‎– The Music Of Love- 1984,(UK),DSF(tracks),(ART-9s+NG-5rd+Tang) in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Scorpions Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Scorpions in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Space Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Space in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/VA - My Favourite Hits of 1991 [32CD] (2018) FLAC от DON Music Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/VA - My Favourite Hits of 1991 [32CD] (2018) FLAC от DON Music in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/VA - My Favourite Hits of 1992 [22CD] (2019) FLAC от DON Music Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/VA - My Favourite Hits of 1992 [22CD] (2019) FLAC от DON Music in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/VA - Vintage Cafe Collection [Lounge & Jazz Blends] FLAC Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/VA - Vintage Cafe Collection [Lounge & Jazz Blends] FLAC in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: Adding Item to queue: music-library/INTERNAL/Various Artists - The Sound of Jazz (1957-2014) [DSD128] Oct 02 13:50:22 volumio volumio[1362]: info: Exploding uri music-library/INTERNAL/Various Artists - The Sound of Jazz (1957-2014) [DSD128] in service mpd Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::stop Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::play index undefined Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:22 volumio volumio[1362]: info: CoreStateMachine::startPlaybackTimer Oct 02 13:50:22 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Oct 02 13:50:22 volumio volumio[1362]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Depeche Mode - Home.wav Oct 02 13:50:22 volumio volumio[1362]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 13:50:22 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=A-Ha/Hunting%20High%20And%20Low%20(Warner%20Bros.%20Records%2C%20P-13153%2C%20Japan)/extralarge&path=%2Fmnt%2FINTERNAL%2FA-Ha%2F1985%20Hunting%20High%20And%20Low%2FA-Ha%20-%20Hunting%20High%20And%20Low.cue&metadata=false Oct 02 13:50:22 volumio volumio[1362]: info: URI /mnt/INTERNAL/A-Ha/1985 Hunting High And Low/A-Ha - Hunting High And Low.cue Oct 02 13:50:22 volumio volumio[1362]: info: ALBUMART /albumart?cacheid=796&web=A-Ha/Hunting%20High%20And%20Low%20(Warner%20Bros.%20Records%2C%20P-13153%2C%20Japan)/extralarge&path=%2Fmnt%2FINTERNAL%2FA-Ha%2F1985%20Hunting%20High%20And%20Low%2FA-Ha%20-%20Hunting%20High%20And%20Low.cue&metadata=false Oct 02 13:50:22 volumio volumio[1362]: info: URI /mnt/INTERNAL/A-Ha/1985 Hunting High And Low/A-Ha - Hunting High And Low.cue Oct 02 13:50:22 volumio volumio[1362]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:50:22 volumio volumio[1362]: Error: Unable to resolve or reject the same promise twice Oct 02 13:50:22 volumio volumio[1362]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 02 13:50:22 volumio volumio[1362]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 02 13:50:22 volumio volumio[1362]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 02 13:50:22 volumio volumio[1362]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 02 13:50:22 volumio volumio[1362]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 02 13:50:22 volumio volumio[1362]: at Socket.emit (node:events:514:28) Oct 02 13:50:22 volumio volumio[1362]: at addChunk (node:internal/streams/readable:343:12) Oct 02 13:50:22 volumio volumio[1362]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 02 13:50:22 volumio volumio[1362]: at Readable.push (node:internal/streams/readable:253:10) Oct 02 13:50:22 volumio volumio[1362]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 02 13:50:22 volumio volumio[1362]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:50:22 volumio sudo[3983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 13:49' Oct 02 13:50:22 volumio sudo[3983]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"