-- Logs begin at Fri 2026-05-22 19:49:20 BST, end at Sun 2026-05-31 15:34:32 BST. -- May 31 15:33:02 primo-aaa volumio[3247]: error: error May 31 15:33:04 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 31 15:33:04 primo-aaa volumio[3247]: info: CURURI: artists://VA.%20Jazz%20Dispensary May 31 15:33:04 primo-aaa volumio[3247]: info: Preload queue cleared May 31 15:33:04 primo-aaa volumio[3247]: info: Preload queue cleared May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/01 - Shake (Ginga Gingou).flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/02 - Soul Samba (Remastered 2026).flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/03 - Dr. Honoris Causa.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/04 - Samba De Oneida.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/05 - Whistle Stop.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/06 - Suddenly.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/07 - Carnival Of Colors.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/08 - Butterfly Dreams.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/01 - Everything Counts.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/02 - Funky Junkie.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/03 - Shifting Gears.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/04 - Don't Leave.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/05 - 24-Carat Black (Theme).flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/06 - Righteousness.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Preloading song: music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/07 - Goodbye, So Long.flac May 31 15:33:04 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/01 - Shake (Ginga Gingou).flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/01 - Shake (Ginga Gingou).flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/02 - Soul Samba (Remastered 2026).flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/02 - Soul Samba (Remastered 2026).flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/03 - Dr. Honoris Causa.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/03 - Dr. Honoris Causa.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/04 - Samba De Oneida.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/04 - Samba De Oneida.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/05 - Whistle Stop.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/05 - Whistle Stop.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/06 - Suddenly.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/06 - Suddenly.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/07 - Carnival Of Colors.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/07 - Carnival Of Colors.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/08 - Butterfly Dreams.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Magia Brasileira (2026) 24BIT-192HZ WEB FLAC/08 - Butterfly Dreams.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/01 - Everything Counts.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/01 - Everything Counts.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/02 - Funky Junkie.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/02 - Funky Junkie.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/03 - Shifting Gears.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/03 - Shifting Gears.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/04 - Don't Leave.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/04 - Don't Leave.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/05 - 24-Carat Black (Theme).flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/05 - 24-Carat Black (Theme).flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/06 - Righteousness.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/06 - Righteousness.flac' May 31 15:33:05 primo-aaa volumio[3247]: info: Exploding uri music-library/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/07 - Goodbye, So Long.flac in service mpd May 31 15:33:05 primo-aaa volumio[3247]: error: scanFolder - failure to stat '/mnt/NAS/USB/1.44.1-86009/HD Music/JAZZ/VA. Jazz Dispensary/Orange Sunset (2020) 24BIT-192KHZ WEB-FLAC/07 - Goodbye, So Long.flac' May 31 15:33:09 primo-aaa volumio[3247]: info: Executing endpoint getSimilarArtists May 31 15:33:09 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists May 31 15:33:10 primo-aaa volumio[3247]: info: Executing endpoint metavolumio May 31 15:33:10 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:33:23 primo-aaa volumio[3247]: info: Retrieving Cloud Streaming UI May 31 15:33:23 primo-aaa volumio[3247]: info: Getting Tidal Cloud Configuration May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:33:23 primo-aaa volumio[3247]: info: Getting Qobuz Cloud Configuration May 31 15:33:23 primo-aaa volumio[3247]: info: Asking plugin for UI Config May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:33:23 primo-aaa volumio[3247]: info: Getting Spotify Cloud Configuration May 31 15:33:23 primo-aaa volumio[3247]: info: Asking plugin for UI Config May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:33:23 primo-aaa volumio[3247]: info: Saving Spotify Acccount May 31 15:33:23 primo-aaa volumio[3247]: info: Got it May 31 15:33:23 primo-aaa volumio[3247]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 31 15:33:23 primo-aaa volumio[3247]: info: Got Tidal Cloud Configuration May 31 15:33:23 primo-aaa volumio[3247]: info: Got it May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:33:23 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::servicePause May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePause May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::pause May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand pause May 31 15:33:25 primo-aaa volumio[3247]: info: May 31 15:33:25 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: player May 31 15:33:25 primo-aaa kernel: asoc-aml-card auge_sound: tdm playback stop May 31 15:33:25 primo-aaa kernel: spdif_a is set to disable May 31 15:33:25 primo-aaa kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 May 31 15:33:25 primo-aaa kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B May 31 15:33:25 primo-aaa kernel: tdm playback mute: 1, lane_cnt = 8 May 31 15:33:25 primo-aaa kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand pause took 5 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand status took 1 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:25 primo-aaa volumio[3247]: info: May 31 15:33:25 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: player May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:25 primo-aaa volumio[3247]: info: May 31 15:33:25 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: player May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 7 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand status took 4 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand status took 3 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:25 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:25 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:25 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:25 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:25.915+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%19 @ 0x2b263c0" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:25 primo-aaa volumio[3247]: info: ------------------------------ 41ms May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 24 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 24 milliseconds May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:25 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:25 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:25 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:25 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:25 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:25 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:25 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:25 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:25 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:25 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:25 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:25 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:25.945+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%19 @ 0x2b263c0" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:25 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:25.946+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%19 @ 0x2b263c0" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:25 primo-aaa volumio[3247]: info: ------------------------------ 59ms May 31 15:33:25 primo-aaa volumio[3247]: info: ------------------------------ 57ms May 31 15:33:25 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:25 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:25 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:26 primo-aaa volumio[3247]: info: MCU Signalled Playback Inactive May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand update May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:29 primo-aaa volumio[3247]: info: May 31 15:33:29 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand update took 86 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:29 primo-aaa volumio[3247]: info: May 31 15:33:29 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:29 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:29 primo-aaa volumio[3247]: info: May 31 15:33:29 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:29 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.221+01:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.222+01:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%19 @ 0x2b263c0" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.222+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.222+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.223+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.224+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand status took 141 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand status took 140 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand status took 139 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand status took 139 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand status took 138 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand status took 137 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:29 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatetrue May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:29 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatetrue May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:29 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatetrue May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 91 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 51 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 11 milliseconds May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:29 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:29 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:29 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:29 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:29 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:29 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:29 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:29 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:29 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:29 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:29 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:29 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:29 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:29 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:29 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:29 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:29 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:29 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:29 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:29 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:29 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:29 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:29 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:29 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.531+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.532+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.532+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.532+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.532+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.533+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.533+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.534+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.534+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.534+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.534+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:29.534+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:29 primo-aaa volumio[3247]: info: ------------------------------ 330ms May 31 15:33:29 primo-aaa volumio[3247]: info: ------------------------------ 328ms May 31 15:33:29 primo-aaa volumio[3247]: info: ------------------------------ 327ms May 31 15:33:29 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:29 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:29 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:31 primo-aaa volumiologrotate[2835]: ls: cannot access '/var/log/samba/log.wb-PRIMO': No such file or directory May 31 15:33:31 primo-aaa volumiologrotate[2835]: ls: cannot access 'AAA': No such file or directory May 31 15:33:32 primo-aaa volumio[3247]: info: MPD Database updated - AlbumList cache refreshed May 31 15:33:32 primo-aaa volumio[3247]: info: May 31 15:33:32 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: database May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: May 31 15:33:32 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 32 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatefalse May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:32 primo-aaa volumio[3247]: info: MPD Database updated - AlbumList cache refreshed May 31 15:33:32 primo-aaa volumio[3247]: info: May 31 15:33:32 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: database May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: May 31 15:33:32 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: MPD Database updated - AlbumList cache refreshed May 31 15:33:32 primo-aaa volumio[3247]: info: May 31 15:33:32 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: database May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: May 31 15:33:32 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 97 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 97 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 16 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 10 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 10 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 8 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 8 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand status took 7 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatefalse May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatefalse May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 98 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 98 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 56 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 56 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 15 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 15 milliseconds May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:32 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:32 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:32 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:32 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:32 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:32 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:32 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:32 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:32 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:32 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:32 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:32 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.727+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.727+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.729+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.729+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.730+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.731+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.732+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.732+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.732+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.732+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.731+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.732+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.732+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.733+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.733+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.734+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.734+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:32.734+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:32 primo-aaa volumio[3247]: info: ------------------------------ 276ms May 31 15:33:32 primo-aaa volumio[3247]: info: ------------------------------ 275ms May 31 15:33:32 primo-aaa volumio[3247]: info: ------------------------------ 190ms May 31 15:33:32 primo-aaa volumio[3247]: info: ------------------------------ 191ms May 31 15:33:32 primo-aaa volumio[3247]: info: ------------------------------ 183ms May 31 15:33:32 primo-aaa volumio[3247]: info: ------------------------------ 184ms May 31 15:33:32 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:32 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:32 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:32 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:32 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:32 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:33 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:35 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:35.773+01:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn May 31 15:33:35 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:35.773+01:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%19 @ 0x2b263c0" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" May 31 15:33:35 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:35.774+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:35 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:35.774+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:35 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:35.774+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:35 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:35.775+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:37 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:40 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:40.755+01:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn May 31 15:33:40 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:40.755+01:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%19 @ 0x2b263c0" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" May 31 15:33:40 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:40.755+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:40 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:40.756+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=239878 volume=30 May 31 15:33:40 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:40.756+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:40 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:40.756+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:41 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:45 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:49 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:53 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:57 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand rescan May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:58 primo-aaa volumio[3247]: info: May 31 15:33:58 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand rescan took 4 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:58 primo-aaa volumio[3247]: info: May 31 15:33:58 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:58 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:58 primo-aaa volumio[3247]: info: May 31 15:33:58 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:58 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand status took 8 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand status took 6 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand status took 6 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand status took 5 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand status took 4 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand status took 4 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:58 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatetrue May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:58 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatetrue May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:58 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatetrue May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 93 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 53 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 13 milliseconds May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:58 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:58 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:58 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:58 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:58 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:58 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:58 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:58 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:58 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:58 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:58 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:58 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:58 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:58 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:58 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:58 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:58 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:58 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:58 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:58 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:58 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:58 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:58 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:58 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.374+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.374+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.375+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.375+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.378+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.378+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.379+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.379+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.380+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.381+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.381+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:58 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:58.381+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:58 primo-aaa volumio[3247]: info: ------------------------------ 197ms May 31 15:33:58 primo-aaa volumio[3247]: info: ------------------------------ 195ms May 31 15:33:58 primo-aaa volumio[3247]: info: ------------------------------ 194ms May 31 15:33:58 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:58 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:58 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:59 primo-aaa volumio[3247]: info: May 31 15:33:59 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:59 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:59 primo-aaa volumio[3247]: info: May 31 15:33:59 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:59 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:59 primo-aaa volumio[3247]: info: May 31 15:33:59 primo-aaa volumio[3247]: ---------------------------- MPD announces state update: update May 31 15:33:59 primo-aaa volumio[3247]: info: ControllerMpd::getState May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand status May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand status took 7 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand status took 6 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand status took 5 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand status took 5 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand status took 5 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand status took 3 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:59 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatefalse May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:59 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatefalse May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:59 primo-aaa volumio[3247]: info: Command Router : Notfying DB Updatefalse May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::Close All Modals sent May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseState May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 92 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 53 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: info: sendMpdCommand playlistinfo took 15 milliseconds May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:59 primo-aaa volumio[3247]: verbose: ControllerMpd::parseTrackInfo May 31 15:33:59 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:59 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:59 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:59 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:59 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:59 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:59 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:59 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:59 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:59 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:59 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:59 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:59 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:59 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:59 primo-aaa volumio[3247]: info: ControllerMpd::pushState May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::servicePushState May 31 15:33:59 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:59 primo-aaa volumio[3247]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":240192,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"When Love Comes To Town (featuring U2)","artist":"B.B. King","album":"When Love Comes To Town 1985-1993 (Remastered)","uri":"NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a","trackType":"m4a"} May 31 15:33:59 primo-aaa volumio[3247]: verbose: CURRENT POSITION 2 May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::syncState stateService pause May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::syncState currentStatus pause May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::pushState May 31 15:33:59 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:33:59 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioPushState May 31 15:33:59 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output update for this device May 31 15:33:59 primo-aaa volumio[3247]: info: MRS: Pushing multiroomSync output May 31 15:33:59 primo-aaa volumio[3247]: info: CoreStateMachine::stPlaybackTimer May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.249+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.250+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.251+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.251+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.250+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.251+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.252+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.252+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.253+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.252+01:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" state=STATUS_PAUSED positionMs=240127 volume=30 May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.253+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.119:54495 @ 0x28002d0" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:59 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:33:59.254+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" id="mnt/NAS/USB/1.44.1-86009/SD Music/B.B. King/Ladies & Gentlemen...Mr. B.B.King 10CD Box (2012)/When Love Comes To Town 1985-1993 (Remastered)/When Love Comes To Town (featuring U2).m4a" title="3 - When Love Comes To Town (featuring U2)" May 31 15:33:59 primo-aaa volumio[3247]: info: ------------------------------ 187ms May 31 15:33:59 primo-aaa volumio[3247]: info: ------------------------------ 186ms May 31 15:33:59 primo-aaa volumio[3247]: info: ------------------------------ 184ms May 31 15:33:59 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:59 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:33:59 primo-aaa volumio[3247]: info: Updating RAAT Signal Path May 31 15:34:01 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:34:01 primo-aaa volumio[3247]: error: error May 31 15:34:05 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:34:12 primo-aaa volumio5-onboarding[3606]: time=2026-05-31T15:34:12.690+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="00:00:00:00:00:00%22,192.168.1.119:54495 @ 0x2920f30" latency=82.83323ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE May 31 15:34:16 primo-aaa sudo[5797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 15:34:16 primo-aaa sudo[5797]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 15:34:16 primo-aaa sudo[5797]: pam_unix(sudo:session): session closed for user root May 31 15:34:16 primo-aaa sudo[5801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 15:34:16 primo-aaa sudo[5801]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 15:34:16 primo-aaa sudo[5801]: pam_unix(sudo:session): session closed for user root May 31 15:34:16 primo-aaa volumio[3247]: verbose: New Socket.io Connection to 192.168.1.234 from 192.168.1.119 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 May 31 15:34:16 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 15:34:16 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 31 15:34:17 primo-aaa sudo[5805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 15:34:17 primo-aaa sudo[5805]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 15:34:17 primo-aaa sudo[5805]: pam_unix(sudo:session): session closed for user root May 31 15:34:17 primo-aaa sudo[5809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 15:34:17 primo-aaa sudo[5809]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 15:34:17 primo-aaa sudo[5809]: pam_unix(sudo:session): session closed for user root May 31 15:34:17 primo-aaa volumio[3247]: verbose: New Socket.io Connection to 192.168.1.234 from 192.168.1.119 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetVisibleSources May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetState May 31 15:34:17 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 15:34:17 primo-aaa volumio[3247]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 31 15:34:17 primo-aaa volumio[3247]: info: Received Get System Info May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 15:34:17 primo-aaa volumio[3247]: info: Discovery: Getting this device information May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetState May 31 15:34:17 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetState May 31 15:34:17 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:34:17 primo-aaa volumio[3247]: info: Listing playlists May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 31 15:34:17 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 31 15:34:18 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 31 15:34:19 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 15:34:19 primo-aaa volumio[3247]: info: Received Get System Info May 31 15:34:19 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 15:34:19 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 15:34:19 primo-aaa volumio[3247]: info: Discovery: Getting this device information May 31 15:34:19 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetState May 31 15:34:19 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:34:19 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 15:34:20 primo-aaa volumio[3247]: info: Received Get System Info May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 15:34:20 primo-aaa volumio[3247]: info: Discovery: Getting this device information May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetState May 31 15:34:20 primo-aaa volumio[3247]: info: CorePlayQueue::getTrack 2 May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:34:20 primo-aaa volumio[3247]: info: Retrieving Cloud Streaming UI May 31 15:34:20 primo-aaa volumio[3247]: info: Getting Tidal Cloud Configuration May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:34:20 primo-aaa volumio[3247]: info: Getting Qobuz Cloud Configuration May 31 15:34:20 primo-aaa volumio[3247]: info: Asking plugin for UI Config May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:34:20 primo-aaa volumio[3247]: info: Getting Spotify Cloud Configuration May 31 15:34:20 primo-aaa volumio[3247]: info: Asking plugin for UI Config May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:34:20 primo-aaa volumio[3247]: info: Saving Spotify Acccount May 31 15:34:20 primo-aaa volumio[3247]: info: Got it May 31 15:34:20 primo-aaa volumio[3247]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 31 15:34:20 primo-aaa volumio[3247]: info: Got Tidal Cloud Configuration May 31 15:34:20 primo-aaa volumio[3247]: info: Got it May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:34:20 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 31 15:34:26 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:34:26 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 31 15:34:26 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 31 15:34:27 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 31 15:34:29 primo-aaa volumio[3247]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 15:34:31 primo-aaa volumiologrotate[2835]: ls: cannot access '/var/log/samba/log.wb-PRIMO': No such file or directory May 31 15:34:31 primo-aaa volumiologrotate[2835]: ls: cannot access 'AAA': No such file or directory May 31 15:34:31 primo-aaa volumiologrotate[2835]: Total log size is greater than 18MB, cleaning logs May 31 15:34:31 primo-aaa volumiologrotate[2835]: Clearing /var/log/mpd.log May 31 15:34:31 primo-aaa volumiologrotate[2835]: Clearing /var/log/samba/log.smbd May 31 15:34:31 primo-aaa volumiologrotate[2835]: ls: cannot access '/var/log/samba/log.wb-PRIMO': No such file or directory May 31 15:34:31 primo-aaa volumiologrotate[2835]: ls: cannot access 'AAA': No such file or directory May 31 15:34:31 primo-aaa volumiologrotate[2835]: Clearing /var/log/samba/log.winbindd May 31 15:34:31 primo-aaa volumio[3247]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 15:34:31 primo-aaa volumiologrotate[2835]: Clearing /var/log/samba/log.nmbd May 31 15:34:31 primo-aaa volumio[3247]: Error: dns service error: unknown May 31 15:34:31 primo-aaa volumio[3247]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 31 15:34:31 primo-aaa volumio[3247]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 31 15:34:31 primo-aaa volumio[3247]: errorCode: -65537 May 31 15:34:31 primo-aaa volumio[3247]: } May 31 15:34:31 primo-aaa volumio[3247]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 15:34:31 primo-aaa volumiologrotate[2835]: Clearing /var/log/wtmp May 31 15:34:31 primo-aaa volumiologrotate[2835]: Clearing /var/log/boot.log May 31 15:34:32 primo-aaa sudo[5928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-31 15:33 May 31 15:34:32 primo-aaa sudo[5928]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 12:16:07 PM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="88686576587e39571d6cf25f3920fbc0"