Feb 10 13:16:25 volumio go-librespot[1502]: time="2026-02-10T13:16:25+09:00" level=trace msg="sent dealer ping" Feb 10 13:16:25 volumio go-librespot[1502]: time="2026-02-10T13:16:25+09:00" level=trace msg="received dealer pong" Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::ClearQueue Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::stPlaybackTimer Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::serviceStop Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::serviceStop Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::stop Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::clearPlayQueue Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::addQueueItems Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::addQueueItems Feb 10 13:16:45 volumio volumio[1143]: info: Preload queue cleared Feb 10 13:16:45 volumio volumio[1143]: info: Adding Item to queue: music-library/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005) Feb 10 13:16:45 volumio volumio[1143]: info: Exploding uri music-library/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005) in service mpd Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.953+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.953+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Antonio Forcione & Sabine Sciubba - Meet Me in London (1988) @/01 Antonio Forcione & Sabina Sciubba - Visions.flac" title="1 - Visions" Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F01.%20Intro%20Duction.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F02.%20Bruce%20Lee.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F03.%20La%20Villette.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/03. La Villette.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F04.%20Behind%20The%20Smile.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/04. Behind The Smile.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F05.%20Frankenstein.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/05. Frankenstein.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F06.%20Moonlight%20Sonata.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/06. Moonlight Sonata.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F07.%20Boogie%20On%20Reggae%20Woman.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/07. Boogie On Reggae Woman.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F08.%20Paris%20(Interlude).flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/08. Paris (Interlude).flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F09.%20Silver%20Rain.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/09. Silver Rain.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F10.%20Make%20Up%20My%20Mind.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/10. Make Up My Mind.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F11.%20Girls%20and%20Boys.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/11. Girls and Boys.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F12.%20Sophisticated%20Lady.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/12. Sophisticated Lady.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F13.%20Power%20of%20Soul.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/13. Power of Soul.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F14.%20Outro%20Duction.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/14. Outro Duction.flac Feb 10 13:16:45 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Marcus%20Miller/Silver%20Rain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMarcus%20Miller%20-%20Silver%20Rain%20(2005)%2F15.%20The%20Lord's%20Prayer.flac&metadata=false Feb 10 13:16:45 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/15. The Lord's Prayer.flac Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand stop took 11 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPlay Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::play index 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::play index undefined Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::startPlaybackTimer Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::clearAddPlayTracks NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand stop took 1 milliseconds Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand clear Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:16:45 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand clear took 1 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand status took 1 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand status took 1 milliseconds Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand add "NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Visions","artist":"Antonio Forcione & Sabina Sciubba","album":"Meet Me In London","uri":"NAS/FLAC/Jazz/Antonio Forcione & Sabine Sciubba - Meet Me in London (1988) @/01 Antonio Forcione & Sabina Sciubba - Visions.flac","trackType":"flac"} Feb 10 13:16:45 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: No code Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 10 13:16:45 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: No code Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 10 13:16:45 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio[1143]: info: No code Feb 10 13:16:45 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:45 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:45 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.971+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:45.972+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 17ms Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 12ms Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 12ms Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:16:45 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:16:45 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:16:45 volumio volumio[1143]: error: updateQueue error: null Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:16:45 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 12ms Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand add "NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" took 13 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 1ms Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 1ms Feb 10 13:16:45 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand play Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:16:45 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:16:45 volumio volumio[1143]: info: Feb 10 13:16:45 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:16:45 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 6ms Feb 10 13:16:45 volumio volumio[1143]: info: sendMpdCommand play took 5 milliseconds Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 5ms Feb 10 13:16:45 volumio volumio[1143]: info: ------------------------------ 5ms Feb 10 13:16:46 volumio volumio[1143]: info: Feb 10 13:16:46 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:46 volumio volumio[1143]: info: Feb 10 13:16:46 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:46 volumio volumio[1143]: info: Feb 10 13:16:46 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:46 volumio volumio[1143]: info: Feb 10 13:16:46 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:46 volumio volumio[1143]: info: Feb 10 13:16:46 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:46 volumio volumio[1143]: info: Feb 10 13:16:46 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand status took 1 milliseconds Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":31,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Intro Duction","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac","trackType":"flac"} Feb 10 13:16:46 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":31,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Intro Duction","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac","trackType":"flac"} Feb 10 13:16:46 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:16:46 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: ------------------------------ 14ms Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.069+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.070+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.070+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.071+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio[1143]: info: ------------------------------ 17ms Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand status took 13 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":31,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Intro Duction","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac","trackType":"flac"} Feb 10 13:16:46 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:16:46 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":31,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Intro Duction","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac","trackType":"flac"} Feb 10 13:16:46 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:16:46 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":31,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Intro Duction","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac","trackType":"flac"} Feb 10 13:16:46 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:16:46 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.089+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.089+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.090+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.091+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.091+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.092+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio[1143]: info: ------------------------------ 38ms Feb 10 13:16:46 volumio volumio[1143]: info: ------------------------------ 39ms Feb 10 13:16:46 volumio volumio[1143]: info: ------------------------------ 35ms Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 10 13:16:46 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:16:46 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":31,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Intro Duction","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac","trackType":"flac"} Feb 10 13:16:46 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:16:46 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:16:46 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:16:46 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:16:46 volumio volumio[1143]: info: ------------------------------ 52ms Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.111+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.111+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.111+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:16:46 volumio volumio5-onboarding[1393]: time=2026-02-10T13:16:46.111+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:46 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:16:55 volumio go-librespot[1502]: time="2026-02-10T13:16:55+09:00" level=trace msg="sent dealer ping" Feb 10 13:16:55 volumio go-librespot[1502]: time="2026-02-10T13:16:55+09:00" level=trace msg="received dealer pong" Feb 10 13:17:11 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:11 volumio volumio[1143]: info: CorePlayQueue::getTrack 1 Feb 10 13:17:11 volumio volumio[1143]: info: Prefetching next song Feb 10 13:17:11 volumio volumio[1143]: info: DOING PREFETCH IN MPD Feb 10 13:17:11 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand add "NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac" Feb 10 13:17:11 volumio volumio[1143]: info: Feb 10 13:17:11 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:11 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:11 volumio volumio[1143]: info: sendMpdCommand add "NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac" took 1 milliseconds Feb 10 13:17:11 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 10 13:17:11 volumio volumio[1143]: info: Feb 10 13:17:11 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:11 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:11 volumio volumio[1143]: info: Feb 10 13:17:11 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:11 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:11 volumio volumio[1143]: info: ------------------------------ 1ms Feb 10 13:17:11 volumio volumio[1143]: info: sendMpdCommand consume 1 took 1 milliseconds Feb 10 13:17:11 volumio volumio[1143]: info: ------------------------------ 1ms Feb 10 13:17:11 volumio volumio[1143]: info: ------------------------------ 1ms Feb 10 13:17:15 volumio volumio[1143]: info: Feb 10 13:17:15 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:15 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:15 volumio volumio[1143]: info: Feb 10 13:17:15 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:15 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:15 volumio volumio[1143]: info: Feb 10 13:17:15 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:15 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:15 volumio volumio[1143]: info: Feb 10 13:17:15 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:15 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:15 volumio volumio[1143]: info: Feb 10 13:17:15 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:15 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:15 volumio volumio[1143]: info: Feb 10 13:17:15 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:15 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:15 volumio volumio[1143]: info: ------------------------------ 1ms Feb 10 13:17:15 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:15 volumio volumio[1143]: info: ------------------------------ 2ms Feb 10 13:17:15 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:15 volumio volumio[1143]: info: ------------------------------ 2ms Feb 10 13:17:15 volumio volumio[1143]: info: sendMpdCommand status took 1 milliseconds Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:15 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 10 13:17:15 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 10 13:17:15 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:15 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:15 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":323,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Bruce Lee","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac","trackType":"flac"} Feb 10 13:17:15 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:15 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:15 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":323,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Bruce Lee","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac","trackType":"flac"} Feb 10 13:17:15 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:15 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:15 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":323,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"Bruce Lee","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac","trackType":"flac"} Feb 10 13:17:15 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:15 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:15 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.648+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=30383 volume=100 Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.648+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=30383 volume=100 Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=30383 volume=100 Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=30383 volume=100 Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=30383 volume=100 Feb 10 13:17:15 volumio volumio[1143]: info: ------------------------------ 8ms Feb 10 13:17:15 volumio volumio[1143]: info: ------------------------------ 9ms Feb 10 13:17:15 volumio volumio[1143]: info: ------------------------------ 8ms Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=30383 volume=100 Feb 10 13:17:15 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:15.649+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/01. Intro Duction.flac" title="1 - Intro Duction" Feb 10 13:17:15 volumio volumio[1143]: info: CoreStateMachine::startPlaybackTimer Feb 10 13:17:15 volumio volumio[1143]: info: CorePlayQueue::getTrack 1 Feb 10 13:17:15 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:15 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:15 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:15 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:15 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:15 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:16 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:16 volumio volumio[1143]: info: CorePlayQueue::getTrack 1 Feb 10 13:17:16 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:16 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:16 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:16.200+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=501 volume=100 Feb 10 13:17:16 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:16.200+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac" title="2 - Bruce Lee" Feb 10 13:17:16 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:25 volumio go-librespot[1502]: time="2026-02-10T13:17:25+09:00" level=trace msg="sent dealer ping" Feb 10 13:17:25 volumio go-librespot[1502]: time="2026-02-10T13:17:25+09:00" level=trace msg="received dealer pong" Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::ClearQueue Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::stPlaybackTimer Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 1 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::serviceStop Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 1 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::serviceStop Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::stop Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::clearPlayQueue Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::addQueueItems Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::addQueueItems Feb 10 13:17:32 volumio volumio[1143]: info: Preload queue cleared Feb 10 13:17:32 volumio volumio[1143]: info: Adding Item to queue: music-library/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC] Feb 10 13:17:32 volumio volumio[1143]: info: Exploding uri music-library/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC] in service mpd Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.585+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.585+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac" title="2 - Bruce Lee" Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F01-%20Spain%20Intro.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F02-%20Spain.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/02- Spain.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F03-%20Besame%20Mucho.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/03- Besame Mucho.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F04-%20A%20mi%20nino%20Jose.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/04- A mi nino Jose.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F05-%20Two%20Much%20-%20Love%20Theme.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/05- Two Much - Love Theme.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F06-%20Para%20Troilo%20y%20Salgan.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/06- Para Troilo y Salgan.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F07-%20La%20Vacilona.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/07- La Vacilona.flac Feb 10 13:17:32 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Michel%20Camilo%20%26%20Tomatito/Spain/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMichel%20Camilo%20%26%20Tomatito%20-%20Spain%20%5B2000%5D%20%5BFLAC%5D%2F08-%20Aire%20de%20Tango.flac&metadata=false Feb 10 13:17:32 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/08- Aire de Tango.flac Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand stop took 41 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPlay Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::play index 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::play index undefined Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::startPlaybackTimer Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::clearAddPlayTracks NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 5 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand stop took 3 milliseconds Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand clear Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:32 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand clear took 2 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand add "NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bruce Lee","artist":"Marcus Miller","album":"Silver Rain","uri":"NAS/FLAC/Jazz/Marcus Miller - Silver Rain (2005)/02. Bruce Lee.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: No code Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: No code Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: No code Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.608+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.608+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.608+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.609+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.610+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.610+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.610+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 26ms Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 20ms Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 20ms Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:32 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:32 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:32 volumio volumio[1143]: error: updateQueue error: null Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:32 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 21ms Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand add "NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" took 20 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 2ms Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 2ms Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand play Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:32 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:32 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 10ms Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand play took 9 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 8ms Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 8ms Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: info: Feb 10 13:17:32 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"343 Kbps","isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"343 Kbps","isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:32 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"343 Kbps","isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:32 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 14ms Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.680+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.680+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.680+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.680+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.681+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.681+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.681+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.681+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 15ms Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 17ms Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand status took 14 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"343 Kbps","isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:32 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"343 Kbps","isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:32 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.694+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 28ms Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 28ms Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.695+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.698+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.696+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.699+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.700+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.700+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.701+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 10 13:17:32 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:32 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"343 Kbps","isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:32 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:32 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:32 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:32 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.721+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.721+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio[1143]: info: ------------------------------ 54ms Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.725+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=844 volume=100 Feb 10 13:17:32 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:32.725+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:32 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::ClearQueue Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::stPlaybackTimer Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::serviceStop Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::serviceStop Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::stop Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::clearPlayQueue Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::addQueueItems Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::addQueueItems Feb 10 13:17:43 volumio volumio[1143]: info: Preload queue cleared Feb 10 13:17:43 volumio volumio[1143]: info: Adding Item to queue: music-library/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC] Feb 10 13:17:43 volumio volumio[1143]: info: Exploding uri music-library/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC] in service mpd Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.338+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.338+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac" title="1 - Spain Intro" Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand stop took 10 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20Of%20Blue/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20Of%20Blue%20(2013)%20%5B24-192%20HD%20FLAC%5D%2F01-So%20What.flac&metadata=false Feb 10 13:17:43 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac Feb 10 13:17:43 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20Of%20Blue/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20Of%20Blue%20(2013)%20%5B24-192%20HD%20FLAC%5D%2F02-Freddie%20Freeloader.flac&metadata=false Feb 10 13:17:43 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/02-Freddie Freeloader.flac Feb 10 13:17:43 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20Of%20Blue/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20Of%20Blue%20(2013)%20%5B24-192%20HD%20FLAC%5D%2F03-Blue%20in%20Green.flac&metadata=false Feb 10 13:17:43 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/03-Blue in Green.flac Feb 10 13:17:43 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20Of%20Blue/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20Of%20Blue%20(2013)%20%5B24-192%20HD%20FLAC%5D%2F04-All%20Blues.flac&metadata=false Feb 10 13:17:43 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/04-All Blues.flac Feb 10 13:17:43 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20Of%20Blue/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20Of%20Blue%20(2013)%20%5B24-192%20HD%20FLAC%5D%2F05-Flamenco%20Sketches.flac&metadata=false Feb 10 13:17:43 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/05-Flamenco Sketches.flac Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPlay Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::play index 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::play index undefined Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::startPlaybackTimer Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::clearAddPlayTracks NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 2 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand stop took 0 milliseconds Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand clear Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:43 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand clear took 3 milliseconds Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand add "NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: No code Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: No code Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spain Intro","artist":"Michel Camilo & Tomatito","album":"Spain","uri":"NAS/FLAC/Jazz/Michel Camilo & Tomatito - Spain [2000] [FLAC]/01- Spain Intro.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: No code Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.354+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.354+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.355+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.355+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.355+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.355+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.356+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=2 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.357+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.357+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.357+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.357+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.357+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 15ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 16ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 15ms Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:43 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:43 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:43 volumio volumio[1143]: error: updateQueue error: null Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:43 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 11ms Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand add "NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" took 11 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 2ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 2ms Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand play Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:43 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces system playlist update Feb 10 13:17:43 volumio volumio[1143]: info: Ignoring MPD Status Update Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 8ms Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand play took 8 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 7ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 7ms Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 52 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 52 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 51 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: Feb 10 13:17:43 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::getState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand status Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 3 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand status took 4 milliseconds Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseState Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":548,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4253 Kbps","isStreaming":false,"title":"So What","artist":"Miles Davis","album":"Kind Of Blue","uri":"NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus stop Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":186,"duration":548,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4253 Kbps","isStreaming":false,"title":"So What","artist":"Miles Davis","album":"Kind Of Blue","uri":"NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:43 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":193,"duration":548,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4250 Kbps","isStreaming":false,"title":"So What","artist":"Miles Davis","album":"Kind Of Blue","uri":"NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:43 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 61ms Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.473+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=186 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.473+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.474+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=193 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.474+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.474+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=186 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.474+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.474+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=193 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.474+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 63ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 64ms Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 10 13:17:43 volumio volumio[1143]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: verbose: ControllerMpd::parseTrackInfo Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":548,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4824 Kbps","isStreaming":false,"title":"So What","artist":"Miles Davis","album":"Kind Of Blue","uri":"NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:43 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":548,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4824 Kbps","isStreaming":false,"title":"So What","artist":"Miles Davis","album":"Kind Of Blue","uri":"NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:43 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: ControllerMpd::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::servicePushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":995,"duration":548,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4824 Kbps","isStreaming":false,"title":"So What","artist":"Miles Davis","album":"Kind Of Blue","uri":"NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac","trackType":"flac"} Feb 10 13:17:43 volumio volumio[1143]: verbose: CURRENT POSITION 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState stateService play Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::syncState currentStatus play Feb 10 13:17:43 volumio volumio[1143]: info: Received an update from plugin. extracting info from payload Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:43 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:43 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.484+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=995 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.484+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.484+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=995 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.484+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.484+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=995 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.484+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.485+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=995 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.485+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.485+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=995 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.485+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.485+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_PLAYING positionMs=995 volume=100 Feb 10 13:17:43 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:43.485+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 23ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 22ms Feb 10 13:17:43 volumio volumio[1143]: info: ------------------------------ 22ms Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:43 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:48 volumio volumio[1143]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::ClearQueue Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::stop Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::stPlaybackTimer Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::updateTrackBlock Feb 10 13:17:48 volumio volumio[1143]: info: CorePlayQueue::getTrackBlock Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::pushState Feb 10 13:17:48 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:48 volumio volumio[1143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 13:17:48 volumio volumio[1143]: info: CoreCommandRouter::volumioPushState Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::serviceStop Feb 10 13:17:48 volumio volumio[1143]: info: CorePlayQueue::getTrack 0 Feb 10 13:17:48 volumio volumio[1143]: info: CoreCommandRouter::serviceStop Feb 10 13:17:48 volumio volumio[1143]: info: ControllerMpd::stop Feb 10 13:17:48 volumio volumio[1143]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 13:17:48 volumio volumio[1143]: info: CorePlayQueue::clearPlayQueue Feb 10 13:17:48 volumio volumio[1143]: info: CorePlayQueue::saveQueue Feb 10 13:17:48 volumio volumio[1143]: info: CoreCommandRouter::volumioPushQueue Feb 10 13:17:48 volumio volumio[1143]: info: CoreStateMachine::addQueueItems Feb 10 13:17:48 volumio volumio[1143]: info: CorePlayQueue::addQueueItems Feb 10 13:17:48 volumio volumio[1143]: info: Preload queue cleared Feb 10 13:17:48 volumio volumio[1143]: info: Adding Item to queue: music-library/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC] Feb 10 13:17:48 volumio volumio[1143]: info: Exploding uri music-library/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC] in service mpd Feb 10 13:17:48 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:48.497+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 13:17:48 volumio volumio5-onboarding[1393]: time=2026-02-10T13:17:48.497+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:46626 @ 0xc00048e3c0" id="mnt/NAS/FLAC/Jazz/Miles Davis - Kind Of Blue (2013) [24-192 HD FLAC]/01-So What.flac" title="1 - So What" Feb 10 13:17:48 volumio volumio[1143]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 13:17:48 volumio volumio[1143]: info: Feb 10 13:17:48 volumio volumio[1143]: ---------------------------- MPD announces state update: player Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F01.%20Miles%20Davis%20_%20So%20What.flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/01. Miles Davis _ So What.flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F02.%20Miles%20Davis%20_%20Freddie%20Freeloader.flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/02. Miles Davis _ Freddie Freeloader.flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F03.%20Miles%20Davis%20_%20Blue%20In%20Green.flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/03. Miles Davis _ Blue In Green.flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F04.%20Miles%20Davis%20_%20All%20Blues.flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/04. Miles Davis _ All Blues.flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F05.%20Miles%20Davis%20_%20Flamenco%20Sketches.flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/05. Miles Davis _ Flamenco Sketches.flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F06.%20Miles%20Davis%20_%20Flamenco%20Sketches%20(alternate%20take).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/06. Miles Davis _ Flamenco Sketches (alternate take).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F07.%20Miles%20Davis%20_%20Freddie%20Freeloader%20(studio%20sequence%201).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/07. Miles Davis _ Freddie Freeloader (studio sequence 1).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F08.%20Miles%20Davis%20_%20Freddie%20Freeloader%20(false%20start).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/08. Miles Davis _ Freddie Freeloader (false start).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F09.%20Miles%20Davis%20_%20Freddie%20Freeloader%20(studio%20sequence%202).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/09. Miles Davis _ Freddie Freeloader (studio sequence 2).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F10.%20Miles%20Davis%20_%20So%20What%20(studio%20sequence%201).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/10. Miles Davis _ So What (studio sequence 1).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F11.%20Miles%20Davis%20_%20So%20What%20(studio%20sequence%202).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/11. Miles Davis _ So What (studio sequence 2).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F12.%20Miles%20Davis%20_%20Blue%20In%20Green%20(studio%20sequence).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/12. Miles Davis _ Blue In Green (studio sequence).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F13.%20Miles%20Davis%20_%20Flamenco%20Sketches%20(studio%20(sequence%201).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/13. Miles Davis _ Flamenco Sketches (studio (sequence 1).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F14.%20Miles%20Davis%20_%20Flamenco%20Sketches%20(studio%20(sequence%202).flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/14. Miles Davis _ Flamenco Sketches (studio (sequence 2).flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2F15.%20Miles%20Davis%20_%20All%20Blues%20-%20studio%20sequence.flac&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/15. Miles Davis _ All Blues - studio sequence.flac Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2FMiles%20Davis%20-%20Kind%20of%20Blue_%2050th%20Anniversary%20-%20CD%201.cue&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/Miles Davis - Kind of Blue_ 50th Anniversary - CD 1.cue Feb 10 13:17:48 volumio volumio[1143]: info: ALBUMART /albumart?cacheid=271&web=Miles%20Davis/Kind%20of%20Blue%3A%2050th%20Anniversary%20-%20CD%201/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FMiles%20Davis%20-%20Kind%20of%20Blue%2050th%20Anniversary%20Collectors%20Edition%202CD%20(2008)%20%5BFLAC%5D%2FCD%201%2FMiles%20Davis%20-%20Kind%20of%20Blue_%2050th%20Anniversary%20-%20CD%201.cue&metadata=false Feb 10 13:17:48 volumio volumio[1143]: info: URI /mnt/NAS/FLAC/Jazz/Miles Davis - Kind of Blue 50th Anniversary Collectors Edition 2CD (2008) [FLAC]/CD 1/Miles Davis - Kind of Blue_ 50th Anniversary - CD 1.cue Feb 10 13:17:48 volumio volumio[1143]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 13:17:48 volumio volumio[1143]: Error: Unable to resolve or reject the same promise twice Feb 10 13:17:48 volumio volumio[1143]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 10 13:17:48 volumio volumio[1143]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Feb 10 13:17:48 volumio volumio[1143]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Feb 10 13:17:48 volumio volumio[1143]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Feb 10 13:17:48 volumio volumio[1143]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Feb 10 13:17:48 volumio volumio[1143]: at Socket.emit (node:events:514:28) Feb 10 13:17:48 volumio volumio[1143]: at addChunk (node:internal/streams/readable:343:12) Feb 10 13:17:48 volumio volumio[1143]: at readableAddChunk (node:internal/streams/readable:312:11) Feb 10 13:17:48 volumio volumio[1143]: at Readable.push (node:internal/streams/readable:253:10) Feb 10 13:17:48 volumio volumio[1143]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Feb 10 13:17:48 volumio volumio[1143]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 13:17:48 volumio sudo[12933]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-10 13:16' Feb 10 13:17:48 volumio sudo[12933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"