Oct 15 20:57:17 volumio volumio[1262]: info: MPD Database updated - AlbumList cache refreshed Oct 15 20:57:17 volumio volumio[1262]: info: Oct 15 20:57:17 volumio volumio[1262]: ---------------------------- MPD announces state update: database Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: Oct 15 20:57:17 volumio volumio[1262]: ---------------------------- MPD announces state update: update Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: MPD Database updated - AlbumList cache refreshed Oct 15 20:57:17 volumio volumio[1262]: info: Oct 15 20:57:17 volumio volumio[1262]: ---------------------------- MPD announces state update: database Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: Oct 15 20:57:17 volumio volumio[1262]: ---------------------------- MPD announces state update: update Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: MPD Database updated - AlbumList cache refreshed Oct 15 20:57:17 volumio volumio[1262]: info: Oct 15 20:57:17 volumio volumio[1262]: ---------------------------- MPD announces state update: database Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: Oct 15 20:57:17 volumio volumio[1262]: ---------------------------- MPD announces state update: update Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:17 volumio volumio[1262]: info: sendMpdCommand status took 809 milliseconds Oct 15 20:57:17 volumio volumio[1262]: info: sendMpdCommand status took 809 milliseconds Oct 15 20:57:17 volumio volumio[1262]: info: sendMpdCommand status took 808 milliseconds Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:17 volumio volumio[1262]: info: Command Router : Notfying DB Updatefalse Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::Close All Modals sent Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:17 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:57:17 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::syncState stateService stop Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:17 volumio volumio[1262]: info: No code Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:17 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:57:17 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::syncState stateService stop Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:17 volumio volumio[1262]: info: No code Oct 15 20:57:17 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:17 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:17 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.984+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.984+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.985+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.986+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.986+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.987+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.988+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.988+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.989+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.989+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.990+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:17 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:17.990+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio[1262]: info: ------------------------------ 932ms Oct 15 20:57:18 volumio volumio[1262]: info: ------------------------------ 932ms Oct 15 20:57:18 volumio volumio[1262]: info: sendMpdCommand status took 1384 milliseconds Oct 15 20:57:18 volumio volumio[1262]: info: sendMpdCommand status took 1384 milliseconds Oct 15 20:57:18 volumio volumio[1262]: info: sendMpdCommand status took 1383 milliseconds Oct 15 20:57:18 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:18 volumio volumio[1262]: info: Command Router : Notfying DB Updatefalse Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::Close All Modals sent Oct 15 20:57:18 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:18 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:18 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:57:18 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::syncState stateService stop Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: No code Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:57:18 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::syncState stateService stop Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: No code Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.532+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.533+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.533+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.533+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.534+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.535+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.535+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.536+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.537+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.537+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.538+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:18 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:18.538+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:18 volumio volumio[1262]: info: ------------------------------ 1471ms Oct 15 20:57:18 volumio volumio[1262]: info: ------------------------------ 1472ms Oct 15 20:57:18 volumio volumio[1262]: info: sendMpdCommand status took 1865 milliseconds Oct 15 20:57:18 volumio volumio[1262]: info: sendMpdCommand status took 1866 milliseconds Oct 15 20:57:18 volumio volumio[1262]: info: sendMpdCommand status took 1865 milliseconds Oct 15 20:57:18 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:18 volumio volumio[1262]: info: Command Router : Notfying DB Updatefalse Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::Close All Modals sent Oct 15 20:57:18 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:18 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:18 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:57:18 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::syncState stateService stop Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:18 volumio volumio[1262]: info: No code Oct 15 20:57:18 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:18 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:18 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:19 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:19 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:19 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:19 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:19 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:19 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:19 volumio volumio[1262]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:57:19 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:19 volumio volumio[1262]: info: CoreStateMachine::syncState stateService stop Oct 15 20:57:19 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:19 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:19 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:19 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:19 volumio volumio[1262]: info: No code Oct 15 20:57:19 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:19 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:19 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.019+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.019+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.020+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.021+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.021+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.022+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.023+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.023+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.024+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.024+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.025+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 15 20:57:19 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:19.025+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/DC8653B5C5615697/Arabesque - II (JP) - 1979/A1 Peppermint Jack.wv" title="A1 Peppermint Jack" Oct 15 20:57:19 volumio volumio[1262]: info: ------------------------------ 1959ms Oct 15 20:57:19 volumio volumio[1262]: info: ------------------------------ 1960ms Oct 15 20:57:21 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 20:57:21 volumio volumio[1262]: info: CURURI: music-library/USB Oct 15 20:57:21 volumio volumio[1262]: info: Preload queue cleared Oct 15 20:57:22 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 20:57:22 volumio volumio[1262]: info: CURURI: music-library/USB/B268C64A806044EB Oct 15 20:57:22 volumio volumio[1262]: info: Preload queue cleared Oct 15 20:57:30 volumio volumio[1262]: info: Preload queue cleared Oct 15 20:57:30 volumio volumio[1262]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 20:57:30 volumio volumio[1262]: info: CoreStateMachine::ClearQueue Oct 15 20:57:30 volumio volumio[1262]: info: CoreStateMachine::stop Oct 15 20:57:30 volumio volumio[1262]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:57:30 volumio volumio[1262]: info: CorePlayQueue::clearPlayQueue Oct 15 20:57:30 volumio volumio[1262]: info: CorePlayQueue::saveQueue Oct 15 20:57:30 volumio volumio[1262]: info: CoreCommandRouter::volumioPushQueue Oct 15 20:57:30 volumio volumio[1262]: info: CoreStateMachine::addQueueItems Oct 15 20:57:30 volumio volumio[1262]: info: CorePlayQueue::addQueueItems Oct 15 20:57:30 volumio volumio[1262]: info: Preload queue cleared Oct 15 20:57:30 volumio volumio[1262]: info: Adding Item to queue: music-library/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean Oct 15 20:57:30 volumio volumio[1262]: info: Exploding uri music-library/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean in service mpd Oct 15 20:57:30 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FA1.%20Claude%20Ciari%20-%20El%20Dia%20Que%20Me%20Quieras%20-%20Slow.flac&metadata=false Oct 15 20:57:30 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac Oct 15 20:57:30 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FA2.%20Claude%20Ciari%20-%20Je%20Chante%20Pour%20Swanee%20-%20Charleston.flac&metadata=false Oct 15 20:57:30 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A2. Claude Ciari - Je Chante Pour Swanee - Charleston.flac Oct 15 20:57:30 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FA3.%20Claude%20Ciari%20-%20Si%20(Chanson%20Italienne%20Du%20Festival%20Eurovision%201974)%20-%20Slow.flac&metadata=false Oct 15 20:57:30 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A3. Claude Ciari - Si (Chanson Italienne Du Festival Eurovision 1974) - Slow.flac Oct 15 20:57:30 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FA4.%20Claude%20Ciari%20-%20La-Bas%20Dans%20Les%20Iles%20-%20Bossa-Nova.flac&metadata=false Oct 15 20:57:30 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A4. Claude Ciari - La-Bas Dans Les Iles - Bossa-Nova.flac Oct 15 20:57:30 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FA5.%20Claude%20Ciari%20-%20Prends%20Ma%20Vie%20-%20Slow-Rock.flac&metadata=false Oct 15 20:57:30 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A5. Claude Ciari - Prends Ma Vie - Slow-Rock.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FA6.%20Claude%20Ciari%20-%20Un%20Reverbere%20-%20Rag.flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A6. Claude Ciari - Un Reverbere - Rag.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FB1.%20Claude%20Ciari%20-%20Dialogue%20-%20Slow.flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/B1. Claude Ciari - Dialogue - Slow.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FB2.%20Claude%20Ciari%20-%20Viens%20Ce%20Soir%20-%20Slow-Rock.flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/B2. Claude Ciari - Viens Ce Soir - Slow-Rock.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FB3.%20Claude%20Ciari%20-%20Madrugada%20-%20Bossa-Nova.flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/B3. Claude Ciari - Madrugada - Bossa-Nova.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FB4.%20Claude%20Ciari%20-%20Lady%20Lay%20-%20Rock%20Lent.flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/B4. Claude Ciari - Lady Lay - Rock Lent.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FB5.%20Claude%20Ciari%20-%20Seul%20-%20Slow.flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/B5. Claude Ciari - Seul - Slow.flac Oct 15 20:57:31 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Claude%20Ciari/Une%20Guitare%20Et%20L'Ocean/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F(1974)%20Claude%20Ciari%20-%20Une%20Guitare%20Et%20L'Ocean%2FB6.%20Claude%20Ciari%20-%20Gentleman%20Cambioleur%20-%20Slow%20(TV%20Film%20Arsene%20Lupin).flac&metadata=false Oct 15 20:57:31 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/B6. Claude Ciari - Gentleman Cambioleur - Slow (TV Film Arsene Lupin).flac Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushQueue Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::saveQueue Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::updateTrackBlock Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrackBlock Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPlay Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::play index 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::stop Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::play index undefined Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::startPlaybackTimer Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::clearAddPlayTracks USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand stop took 2 milliseconds Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Oct 15 20:57:31 volumio volumio[1262]: info: Ignoring MPD Status Update Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand clear took 6 milliseconds Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand add "USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Oct 15 20:57:31 volumio volumio[1262]: info: Ignoring MPD Status Update Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Oct 15 20:57:31 volumio volumio[1262]: info: Ignoring MPD Status Update Oct 15 20:57:31 volumio volumio[1262]: error: updateQueue error: null Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Oct 15 20:57:31 volumio volumio[1262]: info: Ignoring MPD Status Update Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 8ms Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand add "USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" took 6 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 7ms Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 5ms Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand play Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Oct 15 20:57:31 volumio volumio[1262]: info: Ignoring MPD Status Update Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Oct 15 20:57:31 volumio volumio[1262]: info: Ignoring MPD Status Update Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces state update: player Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 12ms Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand play took 9 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 9ms Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 6ms Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces state update: player Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces state update: player Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces state update: player Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand status took 6 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand status took 4 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand status took 3 milliseconds Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces state update: player Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:31 volumio volumio[1262]: info: Oct 15 20:57:31 volumio volumio[1262]: ---------------------------- MPD announces state update: player Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::getState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand status took 20 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand status took 15 milliseconds Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Dia Que Me Quieras - Slow","artist":"Claude Ciari","album":"Une Guitare Et L'Ocean","uri":"USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac","trackType":"flac"} Oct 15 20:57:31 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Dia Que Me Quieras - Slow","artist":"Claude Ciari","album":"Une Guitare Et L'Ocean","uri":"USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac","trackType":"flac"} Oct 15 20:57:31 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:57:31 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Dia Que Me Quieras - Slow","artist":"Claude Ciari","album":"Une Guitare Et L'Ocean","uri":"USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac","trackType":"flac"} Oct 15 20:57:31 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:57:31 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 59ms Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.113+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.114+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.114+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.115+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.116+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.117+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.123+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.123+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 87ms Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 86ms Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand status took 65 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 61 milliseconds Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 58 milliseconds Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseState Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Dia Que Me Quieras - Slow","artist":"Claude Ciari","album":"Une Guitare Et L'Ocean","uri":"USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac","trackType":"flac"} Oct 15 20:57:31 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:57:31 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Dia Que Me Quieras - Slow","artist":"Claude Ciari","album":"Une Guitare Et L'Ocean","uri":"USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac","trackType":"flac"} Oct 15 20:57:31 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:57:31 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.178+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.178+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.180+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.180+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.181+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.181+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.182+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.183+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 146ms Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 139ms Oct 15 20:57:31 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 118 milliseconds Oct 15 20:57:31 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:57:31 volumio volumio[1262]: info: ControllerMpd::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"El Dia Que Me Quieras - Slow","artist":"Claude Ciari","album":"Une Guitare Et L'Ocean","uri":"USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac","trackType":"flac"} Oct 15 20:57:31 volumio volumio[1262]: verbose: CURRENT POSITION 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:57:31 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio[1262]: info: CoreStateMachine::pushState Oct 15 20:57:31 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Oct 15 20:57:31 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.271+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.271+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.272+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" state=STATUS_PLAYING positionMs=0 volume=100 Oct 15 20:57:31 volumio volumio5-onboarding[1640]: time=2026-10-15T20:57:31.272+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:47125 @ 0x2800fc0" id="mnt/USB/B268C64A806044EB/(1974) Claude Ciari - Une Guitare Et L'Ocean/A1. Claude Ciari - El Dia Que Me Quieras - Slow.flac" title="El Dia Que Me Quieras - Slow" Oct 15 20:57:31 volumio volumio[1262]: info: ------------------------------ 216ms Oct 15 20:58:21 volumio ntpd[1049]: PROTO: 156.17.245.123 unlink local addr 192.168.0.120 -> Oct 15 20:58:28 volumio volumio[1262]: info: CoreCommandRouter::volumioAddQueueItems Oct 15 20:58:28 volumio volumio[1262]: info: CoreStateMachine::addQueueItems Oct 15 20:58:28 volumio volumio[1262]: info: CorePlayQueue::addQueueItems Oct 15 20:58:28 volumio volumio[1262]: info: Preload queue cleared Oct 15 20:58:28 volumio volumio[1262]: info: Adding Item to queue: music-library/USB/B268C64A806044EB/Diana Est - Le Louvre 12'' Oct 15 20:58:28 volumio volumio[1262]: info: Exploding uri music-library/USB/B268C64A806044EB/Diana Est - Le Louvre 12'' in service mpd Oct 15 20:58:28 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Diana%20Est/12''%20Vinyl/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2FDiana%20Est%20-%20Le%20Louvre%20%2012''%2FA-Diana%20Est%20-%20Le%20Louvre%20(Vocal)%20(7m%2002s).mp3&metadata=false Oct 15 20:58:28 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/Diana Est - Le Louvre 12''/A-Diana Est - Le Louvre (Vocal) (7m 02s).mp3 Oct 15 20:58:28 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Diana%20Est/12''%20Vinyl/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2FDiana%20Est%20-%20Le%20Louvre%20%2012''%2FB-Diana%20Est%20-%20Le%20Louvre%20(Instrumental%20Stratching%20Version)%20(7m%2022s).mp3&metadata=false Oct 15 20:58:28 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/Diana Est - Le Louvre 12''/B-Diana Est - Le Louvre (Instrumental Stratching Version) (7m 22s).mp3 Oct 15 20:58:28 volumio volumio[1262]: info: CoreCommandRouter::volumioPushQueue Oct 15 20:58:28 volumio volumio[1262]: info: CorePlayQueue::saveQueue Oct 15 20:58:28 volumio volumio[1262]: info: CoreStateMachine::updateTrackBlock Oct 15 20:58:28 volumio volumio[1262]: info: CorePlayQueue::getTrackBlock Oct 15 20:58:33 volumio volumio[1262]: info: CoreCommandRouter::volumioAddQueueItems Oct 15 20:58:33 volumio volumio[1262]: info: CoreStateMachine::addQueueItems Oct 15 20:58:33 volumio volumio[1262]: info: CorePlayQueue::addQueueItems Oct 15 20:58:33 volumio volumio[1262]: info: Preload queue cleared Oct 15 20:58:33 volumio volumio[1262]: info: Adding Item to queue: music-library/USB/B268C64A806044EB/Digital Emotion 2016-26 Oct 15 20:58:33 volumio volumio[1262]: info: Exploding uri music-library/USB/B268C64A806044EB/Digital Emotion 2016-26 in service mpd Oct 15 20:58:33 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2FDigital%20Emotion%202016-26%2F2016%20Full%20Control-Attention%2FDigital%20Emotion%20-%20Full%20Control.wv&metadata=false Oct 15 20:58:33 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/Digital Emotion 2016-26/2016 Full Control-Attention/Digital Emotion - Full Control.wv Oct 15 20:58:33 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Digital%20Emotion/Full%20Control/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2FDigital%20Emotion%202016-26%2F2016%20Full%20Control-Attention%2FDigital%20Emotion%20Full%20Control.cue&metadata=false Oct 15 20:58:33 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/Digital Emotion 2016-26/2016 Full Control-Attention/Digital Emotion Full Control.cue Oct 15 20:58:33 volumio volumio[1262]: info: ALBUMART /albumart?cacheid=602&web=Digital%20Emotion/Full%20Control/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2FDigital%20Emotion%202016-26%2F2016%20Full%20Control-Attention%2FDigital%20Emotion%20Full%20Control.cue&metadata=false Oct 15 20:58:33 volumio volumio[1262]: info: URI /mnt/USB/B268C64A806044EB/Digital Emotion 2016-26/2016 Full Control-Attention/Digital Emotion Full Control.cue Oct 15 20:58:33 volumio volumio[1262]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 20:58:33 volumio volumio[1262]: Error: Unable to resolve or reject the same promise twice Oct 15 20:58:33 volumio volumio[1262]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 15 20:58:33 volumio volumio[1262]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 15 20:58:33 volumio volumio[1262]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 15 20:58:33 volumio volumio[1262]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 15 20:58:33 volumio volumio[1262]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 15 20:58:33 volumio volumio[1262]: at Socket.emit (node:events:514:28) Oct 15 20:58:33 volumio volumio[1262]: at addChunk (node:internal/streams/readable:343:12) Oct 15 20:58:33 volumio volumio[1262]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 15 20:58:33 volumio volumio[1262]: at Readable.push (node:internal/streams/readable:253:10) Oct 15 20:58:33 volumio volumio[1262]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 15 20:58:33 volumio volumio[1262]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 20:58:33 volumio sudo[3584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 20:57' Oct 15 20:58:33 volumio sudo[3584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"