-- Logs begin at Mon 2026-02-16 20:55:16 CET, end at Mon 2026-02-16 21:29:58 CET. --
Feb 16 21:28:40 volumio volumio[1178]: info: Preload queue cleared
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::ClearQueue
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::stop
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::stPlaybackTimer
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::updateTrackBlock
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrackBlock
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 1
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::serviceStop
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 1
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::serviceStop
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::stop
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand stop
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::clearPlayQueue
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::saveQueue
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushQueue
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::addQueueItems
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::addQueueItems
Feb 16 21:28:40 volumio volumio[1178]: info: Preload queue cleared
Feb 16 21:28:40 volumio volumio[1178]: info: Adding Item to queue: albums://Fats%20Domino/My%20Blue%20Heaven
Feb 16 21:28:40 volumio volumio[1178]: info: Exploding uri albums://Fats%20Domino/My%20Blue%20Heaven in service mpd
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.223+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.224+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Various love songs/Fats Domino - Blueberry Hill.flac" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushQueue
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::saveQueue
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::updateTrackBlock
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrackBlock
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPlay
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::play index 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::stop
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::play index undefined
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::startPlaybackTimer
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::clearAddPlayTracks USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand stop
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand stop took 14 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand stop took 2 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand clear
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:28:40 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 1 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand clear took 0 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 0 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 1 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand add "USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3"
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: 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 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService stop
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: No code
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: 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 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService stop
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: No code
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.244+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.244+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.244+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.244+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.244+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.244+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.245+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.245+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.245+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.245+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.245+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.246+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 22ms
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 22ms
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:28:40 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:28:40 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:28:40 volumio volumio[1178]: error: updateQueue error: null
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:28:40 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 23ms
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand add "USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" took 22 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 1ms
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 0ms
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand play
Feb 16 21:28:40 volumio volumio[1178]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 25ms
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:28:40 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:28:40 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 2ms
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand play took 2 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 1ms
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 21 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 20 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 20 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 0 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 0 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 22ms
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info:
Feb 16 21:28:40 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 1 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand status took 1 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":141,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:28:40 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":141,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:28:40 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":141,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:28:40 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.290+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.290+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.290+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.291+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.292+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.292+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.292+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.292+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.292+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 39ms
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 38ms
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 19ms
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 17 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 17 milliseconds
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":141,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:28:40 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":141,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:28:40 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:28:40 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:28:40 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:28:40 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.304+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.305+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.305+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=880 volume=43
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.305+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.305+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.306+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio5-onboarding[1327]: time=2026-02-16T21:28:40.305+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 28ms
Feb 16 21:28:40 volumio volumio[1178]: info: ------------------------------ 29ms
Feb 16 21:28:58 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:28:58 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:28:59 volumio volumio[1178]: Cannot compose Albumart path
Feb 16 21:28:59 volumio volumio[1178]: Cannot compose Albumart path
Feb 16 21:28:59 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:28:59 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:28:59 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:28:59 volumio volumio[1178]: Cannot compose Albumart path
Feb 16 21:28:59 volumio volumio[1178]: Cannot compose Albumart path
Feb 16 21:28:59 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:01 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:29:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:29:02 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:02 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:29:02 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:29:02 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:08 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:29:08 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:29:08 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:09 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:29:09 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:29:09 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:10 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:10 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:10 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:29:10 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:29:11 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:11 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:12 volumio volumio[1178]: Searching plugin music_service/mpd
Feb 16 21:29:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Feb 16 21:29:12 volumio volumio[1178]: info: All search sources collected, pushing search results
Feb 16 21:29:15 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:17 volumio volumio[1178]: verbose: New Socket.io Connection to 192.168.178.72 from 192.168.178.50 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 9
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState
Feb 16 21:29:17 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState
Feb 16 21:29:17 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Feb 16 21:29:17 volumio volumio[1178]: info: CoreStateMachine::getQueue
Feb 16 21:29:17 volumio volumio[1178]: info: CorePlayQueue::getQueue
Feb 16 21:29:17 volumio volumio[1178]: info: Listing playlists
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 16 21:29:17 volumio volumio[1178]: info: Received Get System Info
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 16 21:29:17 volumio volumio[1178]: info: Discovery: Getting this device information
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState
Feb 16 21:29:17 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState
Feb 16 21:29:17 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:29:17 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 16 21:29:22 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:22 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:29 volumio volumio[1178]: info: Preload queue cleared
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::ClearQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::stop
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::stPlaybackTimer
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::updateTrackBlock
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrackBlock
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::serviceStop
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::serviceStop
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::stop
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand stop
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::clearPlayQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::saveQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::addQueueItems
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::addQueueItems
Feb 16 21:29:29 volumio volumio[1178]: info: Preload queue cleared
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/_Klassik/[2010] Klassik Harmonie - Die schönste Klassische Musik zum Träumen & Entspannen (CD 2,3)/06. Tchaikovsky Chamber Orchestra; Lazar Gosman - Streichquartett F-Dur op. 3 Nr. 5, Serenade (Roman Hofstetter).flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/_Klassik/[2010] Klassik Harmonie - Die schönste Klassische Musik zum Träumen & Entspannen (CD 2,3)/06. Tchaikovsky Chamber Orchestra; Lazar Gosman - Streichquartett F-Dur op. 3 Nr. 5, Serenade (Roman Hofstetter).flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/_Klassik/Klassik CD2/02. Franz Joseph Haydn - Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/_Klassik/Klassik CD2/02. Franz Joseph Haydn - Serenade.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac in service mpd
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.906+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.907+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="music-library/USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3" title="Blueberry Hill"
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand stop took 12 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Tchaikovsky%20Chamber%20Orchestra%3B%20Lazar%20Gosman/Klassik%20Harmonie%20-%20Die%20sch%C3%B6nste%20Klassische%20Musik%20zum%20Tr%C3%A4umen%20%26%20Entspannen%20(CD%202%2C3)/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2F_Klassik%2F%5B2010%5D%20Klassik%20Harmonie%20-%20Die%20sch%C3%B6nste%20Klassische%20Musik%20zum%20Tr%C3%A4umen%20%26%20Entspannen%20(CD%202%2C3)%2F06.%20Tchaikovsky%20Chamber%20Orchestra%3B%20Lazar%20Gosman%20-%20Streichquartett%20F-Dur%20op.%203%20Nr.%205%2C%20Serenade%20(Roman%20Hofstetter).flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/_Klassik/[2010] Klassik Harmonie - Die schönste Klassische Musik zum Träumen & Entspannen (CD 2,3)/06. Tchaikovsky Chamber Orchestra; Lazar Gosman - Streichquartett F-Dur op. 3 Nr. 5, Serenade (Roman Hofstetter).flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Franz%20Joseph%20Haydn/Klassik%20CD2/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2F_Klassik%2FKlassik%20CD2%2F02.%20Franz%20Joseph%20Haydn%20-%20Serenade.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/_Klassik/Klassik CD2/02. Franz Joseph Haydn - Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Glenn%20Miller/The%20Best%20Of%20The%20Lost%20Recordings%20%26%20The%20Secret%20Broadcasts/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2F_Sampler%2FOldies%2F06.%20Moonlight%20Serenade.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::saveQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::updateTrackBlock
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrackBlock
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPlay
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::play index 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::addQueueItems
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::addQueueItems
Feb 16 21:29:29 volumio volumio[1178]: info: Preload queue cleared
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/_Wellness/Secret Garden/Songs From A Secret Garden/06. Serenade To Spring.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/_Wellness/Secret Garden/Songs From A Secret Garden/06. Serenade To Spring.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/01. Jessie.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/01. Jessie.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/02. Painted Desert Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/02. Painted Desert Serenade.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/03. Beau's All Night Radio Love Line.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/03. Beau's All Night Radio Love Line.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/04. Invisible Man.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/04. Invisible Man.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/05. Mama's Arms.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/05. Mama's Arms.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/06. Beautiful In My Eyes.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/06. Beautiful In My Eyes.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/07. Picture Postcards From L.A..flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/07. Picture Postcards From L.A..flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/08. When A Woman Cries.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/08. When A Woman Cries.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: Adding Item to queue: music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/09. Georgia Rain.flac
Feb 16 21:29:29 volumio volumio[1178]: info: Exploding uri music-library/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/09. Georgia Rain.flac in service mpd
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::stop
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::play index undefined
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::startPlaybackTimer
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::clearAddPlayTracks USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand stop
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Secret%20Garden/Songs%20From%20A%20Secret%20Garden/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2F_Wellness%2FSecret%20Garden%2FSongs%20From%20A%20Secret%20Garden%2F06.%20Serenade%20To%20Spring.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/_Wellness/Secret Garden/Songs From A Secret Garden/06. Serenade To Spring.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F01.%20Jessie.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/01. Jessie.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F02.%20Painted%20Desert%20Serenade.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/02. Painted Desert Serenade.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F03.%20Beau's%20All%20Night%20Radio%20Love%20Line.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/03. Beau's All Night Radio Love Line.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F04.%20Invisible%20Man.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/04. Invisible Man.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F05.%20Mama's%20Arms.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/05. Mama's Arms.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F06.%20Beautiful%20In%20My%20Eyes.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/06. Beautiful In My Eyes.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F07.%20Picture%20Postcards%20From%20L.A..flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/07. Picture Postcards From L.A..flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F08.%20When%20A%20Woman%20Cries.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/08. When A Woman Cries.flac
Feb 16 21:29:29 volumio volumio[1178]: info: ALBUMART /albumart?cacheid=934&web=Joshua%20Kadison/Painted%20Desert%20Serenade/extralarge&path=%2Fmnt%2FUSB%2F1F7F-E81D%2FJoshua%20Kadison%2FPainted%20Desert%20Serenade%2F09.%20Georgia%20Rain.flac&metadata=false
Feb 16 21:29:29 volumio volumio[1178]: info: URI /mnt/USB/1F7F-E81D/Joshua Kadison/Painted Desert Serenade/09. Georgia Rain.flac
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 8 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand stop took 2 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 2 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 2 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand clear
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::saveQueue
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::updateTrackBlock
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrackBlock
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:29:29 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand clear took 5 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand add "USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac"
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: 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":"Blueberry Hill","artist":"Fats Domino","album":"My Blue Heaven","uri":"USB/1F7F-E81D/_Sampler/Oldies/Fats Domino - Blueberry Hill.mp3","trackType":"mp3"}
Feb 16 21:29:29 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState stateService stop
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: No code
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 16 21:29:29 volumio volumio[1178]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.936+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.936+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.936+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.936+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.937+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_STOPPED positionMs=0 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.937+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 27ms
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 21ms
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:29:29 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:29:29 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:29:29 volumio volumio[1178]: error: updateQueue error: null
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:29:29 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 15ms
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand add "USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" took 14 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 1ms
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 1ms
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand play
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:29:29 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 16 21:29:29 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 1ms
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand play took 2 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 2ms
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 20 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 20 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 20 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 0 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 0 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":157,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"62 Kbps","isStreaming":false,"title":"Moonlight Serenade","artist":"Glenn Miller","album":"The Best Of The Lost Recordings & The Secret Broadcasts","uri":"USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac","trackType":"flac"}
Feb 16 21:29:29 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 21ms
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info:
Feb 16 21:29:29 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::getState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 0 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366,"duration":157,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"382 Kbps","isStreaming":false,"title":"Moonlight Serenade","artist":"Glenn Miller","album":"The Best Of The Lost Recordings & The Secret Broadcasts","uri":"USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac","trackType":"flac"}
Feb 16 21:29:29 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:29:29 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":157,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"374 Kbps","isStreaming":false,"title":"Moonlight Serenade","artist":"Glenn Miller","album":"The Best Of The Lost Recordings & The Secret Broadcasts","uri":"USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac","trackType":"flac"}
Feb 16 21:29:29 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:29:29 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":157,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"321 Kbps","isStreaming":false,"title":"Moonlight Serenade","artist":"Glenn Miller","album":"The Best Of The Lost Recordings & The Secret Broadcasts","uri":"USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac","trackType":"flac"}
Feb 16 21:29:29 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:29:29 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.978+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=366 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.978+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.979+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=366 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.979+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.979+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=480 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.979+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.980+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=480 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.980+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.981+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=869 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.981+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.981+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=869 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.981+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 47ms
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 47ms
Feb 16 21:29:29 volumio volumio[1178]: info: ------------------------------ 28ms
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand status took 27 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 26 milliseconds
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 16 21:29:29 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:29 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":157,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"332 Kbps","isStreaming":false,"title":"Moonlight Serenade","artist":"Glenn Miller","album":"The Best Of The Lost Recordings & The Secret Broadcasts","uri":"USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac","trackType":"flac"}
Feb 16 21:29:29 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:29:29 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:29 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:29 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.998+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=869 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.998+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.998+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=869 volume=43
Feb 16 21:29:29 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:29.998+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:30 volumio volumio[1178]: info: ------------------------------ 34ms
Feb 16 21:29:30 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 10 milliseconds
Feb 16 21:29:30 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 16 21:29:30 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 16 21:29:30 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 16 21:29:30 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:30 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":157,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"332 Kbps","isStreaming":false,"title":"Moonlight Serenade","artist":"Glenn Miller","album":"The Best Of The Lost Recordings & The Secret Broadcasts","uri":"USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac","trackType":"flac"}
Feb 16 21:29:30 volumio volumio[1178]: verbose: CURRENT POSITION 2
Feb 16 21:29:30 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 16 21:29:30 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 16 21:29:30 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 16 21:29:30 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:30 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:30 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:30 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 16 21:29:30 volumio volumio[1178]: info: CorePlayQueue::getTrack 2
Feb 16 21:29:30 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 16 21:29:30 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:30.008+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=869 volume=43
Feb 16 21:29:30 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:30.008+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:30 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:30.008+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" state=STATUS_PLAYING positionMs=869 volume=43
Feb 16 21:29:30 volumio volumio5-onboarding[1327]: time=2026-02-16T21:29:30.008+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.50:49782 @ 0x1f7e030" id="mnt/USB/1F7F-E81D/_Sampler/Oldies/06. Moonlight Serenade.flac" title="Moonlight Serenade"
Feb 16 21:29:30 volumio volumio[1178]: info: ------------------------------ 44ms
Feb 16 21:29:49 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:49 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:49 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:49 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:49 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:50 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:50 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:50 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:51 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:51 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:51 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:51 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:51 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:52 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:53 volumio volumio[1178]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Feb 16 21:29:57 volumio volumio[1178]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 16 21:29:57 volumio volumio[1178]: TypeError: Cannot read property 'slice' of null
Feb 16 21:29:57 volumio volumio[1178]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Feb 16 21:29:57 volumio volumio[1178]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Feb 16 21:29:57 volumio volumio[1178]: at Object.onceWrapper (events.js:422:26)
Feb 16 21:29:57 volumio volumio[1178]: at ClientRequest.emit (events.js:315:20)
Feb 16 21:29:57 volumio volumio[1178]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27)
Feb 16 21:29:57 volumio volumio[1178]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17)
Feb 16 21:29:57 volumio volumio[1178]: at TLSSocket.socketOnData (_http_client.js:509:22)
Feb 16 21:29:57 volumio volumio[1178]: at TLSSocket.emit (events.js:315:20)
Feb 16 21:29:57 volumio volumio[1178]: at addChunk (internal/streams/readable.js:309:12)
Feb 16 21:29:57 volumio volumio[1178]: at readableAddChunk (internal/streams/readable.js:284:9)
Feb 16 21:29:57 volumio volumio[1178]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10)
Feb 16 21:29:57 volumio volumio[1178]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23)
Feb 16 21:29:57 volumio volumio[1178]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 16 21:29:58 volumio sudo[9953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-16 21:28
Feb 16 21:29:58 volumio sudo[9953]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET"
VOLUMIO_VERSION="3.908"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"