-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2024-04-02 20:24:07 CEST. -- Apr 02 20:23:03 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 20:23:03 volumio volumio[887]: info: CURURI: music-library/USB/Crucial_M50/Musica 2024 Apr 02 20:23:03 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:04 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 20:23:04 volumio volumio[887]: info: CURURI: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy Apr 02 20:23:05 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:05 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac Apr 02 20:23:05 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/play.m3u Apr 02 20:23:05 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac in service mpd Apr 02 20:23:05 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Eva%20Cassidy/The%20Best%20Of%20Eva%20Cassidy/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2F2012_Eva%20Cassidy%20The%20Best%20Of%20Eva%20Cassidy%2F20.%20Tall%20Trees%20In%20Georgia.flac&metadata=false Apr 02 20:23:05 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac Apr 02 20:23:05 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/play.m3u in service mpd Apr 02 20:23:07 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 4 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::serviceStop Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 4 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::serviceStop Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::stop Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:23:07 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac Apr 02 20:23:07 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue Apr 02 20:23:07 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue in service mpd Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue Apr 02 20:23:07 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue in service mpd Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/Eva Cassidy - The Best Of Eva Cassidy.cue Apr 02 20:23:07 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/Eva Cassidy - The Best Of Eva Cassidy.cue in service mpd Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/Eva Cassidy - The Best Of Eva Cassidy.cue Apr 02 20:23:07 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/Eva Cassidy - The Best Of Eva Cassidy.cue in service mpd Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/play.m3u Apr 02 20:23:07 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/play.m3u Apr 02 20:23:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue Apr 02 20:23:07 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue in service mpd Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPlay Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::play index 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::clearAddPlayTracks USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand stop took 225 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand stop took 6 milliseconds Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:07 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 16 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand clear took 16 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 15 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 14 milliseconds Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand add "USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac" Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: 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} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: No code Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: 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} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: No code Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 25ms Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 25ms Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:07 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:07 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:07 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand add "USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac" took 15 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 6ms Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:23:07 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 33ms Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:07 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:07 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 8ms Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand play took 7 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 6ms Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 5ms Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:07 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 9 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 8ms Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 18ms Apr 02 20:23:07 volumio volumio[887]: info: Apr 02 20:23:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:07 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:07 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:07 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 30ms Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 30ms Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 29ms Apr 02 20:23:07 volumio volumio[887]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 02 20:23:07 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:07 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:07 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:07 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:07 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:07 volumio volumio[887]: info: ------------------------------ 27ms Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioSeek Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::seek Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: TRACKBLOCK {"uri":"mnt/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","service":"mpd","name":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=175&web=Eva%20Cassidy/The%20Best%20Of%20Eva%20Cassidy/small&path=%2FUSB%2FCrucial_M50%2FMusica%202024%2F2012_Eva%20Cassidy%20The%20Best%20Of%20Eva%20Cassidy&metadata=false","duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::seek Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: error: null Apr 02 20:23:12 volumio volumio[887]: info: Apr 02 20:23:12 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:12 volumio volumio[887]: info: Apr 02 20:23:12 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:12 volumio volumio[887]: info: Apr 02 20:23:12 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:12 volumio volumio[887]: info: sendMpdCommand status took 15 milliseconds Apr 02 20:23:12 volumio volumio[887]: info: sendMpdCommand status took 12 milliseconds Apr 02 20:23:12 volumio volumio[887]: info: sendMpdCommand status took 12 milliseconds Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:12 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:12 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:12 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:12 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51000,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:12 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:12 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"716 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:12 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:12 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"710 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:12 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:12 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:12 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:12 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:12 volumio volumio[887]: info: ------------------------------ 30ms Apr 02 20:23:12 volumio volumio[887]: info: ------------------------------ 28ms Apr 02 20:23:12 volumio volumio[887]: info: ------------------------------ 27ms Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioSeek Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::seek Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: TRACKBLOCK {"uri":"mnt/USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","service":"mpd","name":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=175&web=Eva%20Cassidy/The%20Best%20Of%20Eva%20Cassidy/small&path=%2FUSB%2FCrucial_M50%2FMusica%202024%2F2012_Eva%20Cassidy%20The%20Best%20Of%20Eva%20Cassidy&metadata=false","duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::seek Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: error: null Apr 02 20:23:15 volumio volumio[887]: info: Apr 02 20:23:15 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:15 volumio volumio[887]: info: Apr 02 20:23:15 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:15 volumio volumio[887]: info: Apr 02 20:23:15 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:15 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:15 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:15 volumio volumio[887]: info: sendMpdCommand status took 1 milliseconds Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:15 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:15 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:15 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:15 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":82000,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"812 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:15 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:15 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":82869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:15 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:15 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":82869,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:15 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:15 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:15 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:15 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:15 volumio volumio[887]: info: ------------------------------ 18ms Apr 02 20:23:15 volumio volumio[887]: info: ------------------------------ 17ms Apr 02 20:23:15 volumio volumio[887]: info: ------------------------------ 15ms Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioNext Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::next Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::serviceStop Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::serviceStop Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::stop Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand stop took 4 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand stop took 3 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 1 milliseconds Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:16 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand clear took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand load "USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue" Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: 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":"Tall Trees In Georgia","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/20. Tall Trees In Georgia.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: No code Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 02 20:23:16 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 13ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 12ms Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:16 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:16 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:16 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:16 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 15ms Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand load "USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue" took 14 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 6ms Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:16 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:16 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 19ms Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand play took 16 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 15ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 13ms Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: Apr 02 20:23:16 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 5 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"701 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"701 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:16 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"723 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:16 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 19ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 25ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 24ms Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 02 20:23:16 volumio volumio[887]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:16 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:16 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:16 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:16 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:16 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:16 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 38ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 36ms Apr 02 20:23:16 volumio volumio[887]: info: ------------------------------ 35ms Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioSeek Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::seek Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: TRACKBLOCK {"uri":"cue://USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue@0","service":"mpd","name":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","number":1,"albumart":"/albumart?cacheid=175&web=Eva%20Cassidy/The%20Best%20Of%20Eva%20Cassidy/small&path=%2Fmnt%2F%2FUSB%2FCrucial_M50%2FMusica%202024%2F2012_Eva%20Cassidy%20The%20Best%20Of%20Eva%20Cassidy&metadata=false","duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::seek Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: error: null Apr 02 20:23:18 volumio volumio[887]: info: Apr 02 20:23:18 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:18 volumio volumio[887]: info: Apr 02 20:23:18 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:18 volumio volumio[887]: info: Apr 02 20:23:18 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:18 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:18 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:18 volumio volumio[887]: info: sendMpdCommand status took 1 milliseconds Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:18 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:18 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:18 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:18 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37000,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:18 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:18 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37000,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:18 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:18 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37000,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:18 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:18 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:18 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:18 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:18 volumio volumio[887]: info: ------------------------------ 17ms Apr 02 20:23:18 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:23:18 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioSeek Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::seek Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: TRACKBLOCK {"uri":"cue://USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/edit.flac.cue@0","service":"mpd","name":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","number":1,"albumart":"/albumart?cacheid=175&web=Eva%20Cassidy/The%20Best%20Of%20Eva%20Cassidy/small&path=%2Fmnt%2F%2FUSB%2FCrucial_M50%2FMusica%202024%2F2012_Eva%20Cassidy%20The%20Best%20Of%20Eva%20Cassidy&metadata=false","duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::seek Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: error: null Apr 02 20:23:24 volumio volumio[887]: info: Apr 02 20:23:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:24 volumio volumio[887]: info: Apr 02 20:23:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:24 volumio volumio[887]: info: Apr 02 20:23:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:24 volumio volumio[887]: info: sendMpdCommand status took 6 milliseconds Apr 02 20:23:24 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:24 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 20:23:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:24 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94000,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:24 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:24 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:24 volumio volumio[887]: verbose: CURRENT POSITION 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:24 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:24 volumio volumio[887]: info: ------------------------------ 36ms Apr 02 20:23:24 volumio volumio[887]: info: ------------------------------ 32ms Apr 02 20:23:24 volumio volumio[887]: info: ------------------------------ 32ms Apr 02 20:23:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 20:23:38 volumio volumio[887]: info: CURURI: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012 Apr 02 20:23:38 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:40 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 20:23:40 volumio volumio[887]: info: CURURI: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue Apr 02 20:23:40 volumio volumio[887]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 02 20:23:40 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:43 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: [1712082223802] ---------------------------- Client requests add and Play Volumio CUE entry Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Apr 02 20:23:43 volumio volumio[887]: info: Adding CUE individual entry: 0 USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioAddQueueItems Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:23:43 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:43 volumio volumio[887]: info: Adding Item to queue: cue://USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue@0 Apr 02 20:23:43 volumio volumio[887]: info: Exploding uri cue://USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue@0 in service mpd Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioPlay Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::play index 6 Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::serviceStop Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 1 Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::serviceStop Apr 02 20:23:43 volumio volumio[887]: info: ControllerMpd::stop Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand stop took 12 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 6 Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 6 Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:43 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:43 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand status took 7 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand stop took 5 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:43 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand clear took 4 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand load "USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue" Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:43 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 6 Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 6 Apr 02 20:23:43 volumio volumio[887]: 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":"You Take My Breath Away","artist":"Eva Cassidy","album":"The Best Of Eva Cassidy","uri":"USB/Crucial_M50/Musica 2024/2012_Eva Cassidy The Best Of Eva Cassidy/01. You Take My Breath Away.flac","trackType":"flac"} Apr 02 20:23:43 volumio volumio[887]: verbose: CURRENT POSITION 6 Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 6 Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:43 volumio volumio[887]: info: No code Apr 02 20:23:43 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:43 volumio volumio[887]: info: CorePlayQueue::getTrack 6 Apr 02 20:23:43 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:43 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 02 20:23:43 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 02 20:23:43 volumio volumio[887]: info: ------------------------------ 25ms Apr 02 20:23:43 volumio volumio[887]: info: ------------------------------ 21ms Apr 02 20:23:43 volumio volumio[887]: info: ------------------------------ 20ms Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:43 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:43 volumio volumio[887]: info: Apr 02 20:23:43 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:43 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:43 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:43 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:43 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:43 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:23:43 volumio volumio[887]: info: sendMpdCommand load "USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue" took 14 milliseconds Apr 02 20:23:43 volumio volumio[887]: info: ------------------------------ 2ms Apr 02 20:23:43 volumio volumio[887]: info: ------------------------------ 1ms Apr 02 20:23:43 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:23:45 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:45 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:45 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:23:45 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:45 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue Apr 02 20:23:45 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue in service mpd Apr 02 20:23:45 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:45 volumio volumio[887]: info: CoreCommandRouter::volumioPlay Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::play index 0 Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:45 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:45 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:45 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:45 volumio volumio[887]: info: sendMpdCommand stop took 1 milliseconds Apr 02 20:23:45 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:23:45 volumio volumio[887]: info: Apr 02 20:23:45 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:45 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:45 volumio volumio[887]: info: sendMpdCommand clear took 1 milliseconds Apr 02 20:23:45 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand load "USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue" Apr 02 20:23:45 volumio volumio[887]: info: Apr 02 20:23:45 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:45 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:45 volumio volumio[887]: info: Apr 02 20:23:45 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:45 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:45 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:45 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:45 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:45 volumio volumio[887]: info: ------------------------------ 5ms Apr 02 20:23:45 volumio volumio[887]: info: sendMpdCommand load "USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/Bill Evans - Live At Art D'Lugoff's Top Of The Gate (disc 1).cue" took 3 milliseconds Apr 02 20:23:45 volumio volumio[887]: info: ------------------------------ 3ms Apr 02 20:23:45 volumio volumio[887]: info: ------------------------------ 2ms Apr 02 20:23:45 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:23:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 20:23:49 volumio volumio[887]: info: CURURI: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1 Apr 02 20:23:49 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/02 - Witchcraft.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/03 - Yesterdays.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/04 - 'Round Midnight.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/05 - My Funny Valentine.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/06 - California Here I Come.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/07 - Gone With The Wind.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/08 - Alfie.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/09 - Turn Out The Stars.flac Apr 02 20:23:49 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/play.m3u Apr 02 20:23:49 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac in service mpd Apr 02 20:23:49 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F01%20-%20Emily.flac&metadata=false Apr 02 20:23:49 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/02 - Witchcraft.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F02%20-%20Witchcraft.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/02 - Witchcraft.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/03 - Yesterdays.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F03%20-%20Yesterdays.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/03 - Yesterdays.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/04 - 'Round Midnight.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F04%20-%20'Round%20Midnight.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/04 - 'Round Midnight.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/05 - My Funny Valentine.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F05%20-%20My%20Funny%20Valentine.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/05 - My Funny Valentine.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/06 - California Here I Come.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F06%20-%20California%20Here%20I%20Come.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/06 - California Here I Come.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/07 - Gone With The Wind.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F07%20-%20Gone%20With%20The%20Wind.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/07 - Gone With The Wind.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/08 - Alfie.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F08%20-%20Alfie.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/08 - Alfie.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/09 - Turn Out The Stars.flac in service mpd Apr 02 20:23:50 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Live%20At%20Art%20D'Lugoff's%20Top%20Of%20The%20Gate%20(disc%201)/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Live%20At%20Art%20D%20Lugoff%20s%20Top%20Of%20The%20Gate%202012%2FCD%201%2F09%20-%20Turn%20Out%20The%20Stars.flac&metadata=false Apr 02 20:23:50 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/09 - Turn Out The Stars.flac Apr 02 20:23:50 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/play.m3u in service mpd Apr 02 20:23:51 volumio volumio[887]: info: Adding music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac to favourites using generic method Apr 02 20:23:51 volumio volumio[887]: info: Saving local item favourites Apr 02 20:23:51 volumio volumio[887]: info: Pushing Favourites {"uri":"/mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","favourite":false} Apr 02 20:23:52 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:23:52 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/02 - Witchcraft.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/02 - Witchcraft.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/03 - Yesterdays.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/03 - Yesterdays.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/04 - 'Round Midnight.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/04 - 'Round Midnight.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/05 - My Funny Valentine.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/05 - My Funny Valentine.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/06 - California Here I Come.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/06 - California Here I Come.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/07 - Gone With The Wind.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/07 - Gone With The Wind.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/08 - Alfie.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/08 - Alfie.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/09 - Turn Out The Stars.flac Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/09 - Turn Out The Stars.flac Apr 02 20:23:52 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/play.m3u Apr 02 20:23:52 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/play.m3u Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPlay Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::play index 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::clearAddPlayTracks USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand stop took 1 milliseconds Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:52 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand clear took 1 milliseconds Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand add "USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac" Apr 02 20:23:52 volumio volumio[887]: error: updateQueue error: null Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:52 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 3ms Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand add "USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac" took 1 milliseconds Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:52 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:52 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 7ms Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand play took 5 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 5ms Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 4ms Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:52 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:52 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:23:52 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand status took 5 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 4ms Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 4ms Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:52 volumio volumio[887]: info: Apr 02 20:23:52 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand status took 7 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:23:52 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"656 Kbps","isStreaming":false,"title":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:23:52 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:52 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 21ms Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 23ms Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 02 20:23:52 volumio volumio[887]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:52 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"657 Kbps","isStreaming":false,"title":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:23:52 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:52 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"657 Kbps","isStreaming":false,"title":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:23:52 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:52 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"657 Kbps","isStreaming":false,"title":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:23:52 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:23:52 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:23:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:23:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 45ms Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 42ms Apr 02 20:23:52 volumio volumio[887]: info: ------------------------------ 40ms Apr 02 20:23:59 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 20:23:59 volumio volumio[887]: info: CURURI: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974 Apr 02 20:23:59 volumio volumio[887]: info: Preload queue cleared Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac Apr 02 20:23:59 volumio volumio[887]: info: Preloading song: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/play.m3u Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F01%20-%20Since%20We%20Met.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F02%20-%20Midnight%20Mood.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F03%20-%20See-Saw.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F04%20-%20Sareen%20Jurer.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F05%20-%20Time%20Remembered.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F06%20-%20Turn%20Out%20The%20Stars.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac in service mpd Apr 02 20:23:59 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=The%20Bill%20Evans%20Trio/Since%20We%20Met/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans%20Since_We_Met%20OJC%201974%2F07%20-%20But%20Beautiful.flac&metadata=false Apr 02 20:23:59 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac Apr 02 20:23:59 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/play.m3u in service mpd Apr 02 20:24:00 volumio volumio[887]: info: Preload queue cleared Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::serviceStop Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::serviceStop Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::stop Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:24:00 volumio volumio[887]: info: Preload queue cleared Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/play.m3u Apr 02 20:24:00 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/play.m3u Apr 02 20:24:00 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/extras Apr 02 20:24:00 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/extras in service mpd Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand stop took 10 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPlay Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::play index 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::clearAddPlayTracks USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand stop took 1 milliseconds Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: 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":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: No code Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: 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":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: No code Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: 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":"Emily","artist":"Bill Evans","album":"Live At Art D'Lugoff's Top Of The Gate (disc 1)","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Live At Art D Lugoff s Top Of The Gate 2012/CD 1/01 - Emily.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: No code Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 23ms Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 22ms Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 22ms Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:00 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand clear took 16 milliseconds Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand add "USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac" Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:00 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:00 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:00 volumio volumio[887]: error: updateQueue error: null Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:00 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 8ms Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand add "USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac" took 8 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 3ms Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 2ms Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:00 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 6ms Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand play took 5 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 5ms Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:00 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 3ms Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 6 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 6 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":533,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"Since We Met","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":533,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"Since We Met","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:00 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 14ms Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:24:00 volumio volumio[887]: info: Apr 02 20:24:00 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 02 20:24:00 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:00 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":533,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"565 Kbps","isStreaming":false,"title":"Since We Met","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:00 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":533,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"565 Kbps","isStreaming":false,"title":"Since We Met","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac","trackType":"flac"} Apr 02 20:24:00 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:00 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:00 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:00 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 29ms Apr 02 20:24:00 volumio volumio[887]: info: ------------------------------ 28ms Apr 02 20:24:01 volumio volumio[887]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 02 20:24:01 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:01 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:01 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:01 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:01 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":533,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"565 Kbps","isStreaming":false,"title":"Since We Met","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac","trackType":"flac"} Apr 02 20:24:01 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 02 20:24:01 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:01 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:01 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:01 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:01 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:01 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:01 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:01 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:01 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:01 volumio volumio[887]: info: ------------------------------ 32ms Apr 02 20:24:03 volumio volumio[887]: info: Preload queue cleared Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::serviceStop Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::serviceStop Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::stop Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:24:03 volumio volumio[887]: info: Preload queue cleared Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/01 - Since We Met.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/02 - Midnight Mood.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/03 - See-Saw.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/05 - Time Remembered.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/06 - Turn Out The Stars.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/07 - But Beautiful.flac Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/play.m3u Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/play.m3u Apr 02 20:24:03 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/extras Apr 02 20:24:03 volumio volumio[887]: info: Using cached record of: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/extras Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPlay Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::play index 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::play index undefined Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::clearAddPlayTracks USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand stop took 8 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand stop took 2 milliseconds Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:03 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand clear took 2 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand add "USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac" Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: 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} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: No code Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: 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} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: No code Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 15ms Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 15ms Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:03 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:03 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:03 volumio volumio[887]: error: updateQueue error: null Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:03 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 16ms Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand add "USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac" took 15 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 2ms Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 1ms Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play Apr 02 20:24:03 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 20ms Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:03 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 02 20:24:03 volumio volumio[887]: info: Ignoring MPD Status Update Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 6ms Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand play took 5 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 4ms Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 3 milliseconds Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: Apr 02 20:24:03 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 9 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":400,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sareen Jurer","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac","trackType":"flac"} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":400,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sareen Jurer","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac","trackType":"flac"} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:03 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":400,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sareen Jurer","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac","trackType":"flac"} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:03 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 31ms Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 34ms Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 33ms Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 21 milliseconds Apr 02 20:24:03 volumio volumio[887]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":400,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"556 Kbps","isStreaming":false,"title":"Sareen Jurer","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac","trackType":"flac"} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:03 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":400,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"567 Kbps","isStreaming":false,"title":"Sareen Jurer","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac","trackType":"flac"} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:03 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ControllerMpd::pushState Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":400,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"568 Kbps","isStreaming":false,"title":"Sareen Jurer","artist":"The Bill Evans Trio","album":"Since We Met","uri":"USB/Crucial_M50/Musica 2024/Bill_Evans Since_We_Met OJC 1974/04 - Sareen Jurer.flac","trackType":"flac"} Apr 02 20:24:03 volumio volumio[887]: verbose: CURRENT POSITION 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 02 20:24:03 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:03 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:03 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 55ms Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 49ms Apr 02 20:24:03 volumio volumio[887]: info: ------------------------------ 49ms Apr 02 20:24:07 volumio volumio[887]: info: Preload queue cleared Apr 02 20:24:07 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::stop Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock Apr 02 20:24:07 volumio volumio[887]: info: CorePlayQueue::getTrackBlock Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::pushState Apr 02 20:24:07 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:07 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 20:24:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::serviceStop Apr 02 20:24:07 volumio volumio[887]: info: CorePlayQueue::getTrack 3 Apr 02 20:24:07 volumio volumio[887]: info: CoreCommandRouter::serviceStop Apr 02 20:24:07 volumio volumio[887]: info: ControllerMpd::stop Apr 02 20:24:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 20:24:07 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 02 20:24:07 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 02 20:24:07 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 02 20:24:07 volumio volumio[887]: info: CoreStateMachine::addQueueItems Apr 02 20:24:07 volumio volumio[887]: info: CorePlayQueue::addQueueItems Apr 02 20:24:07 volumio volumio[887]: info: Preload queue cleared Apr 02 20:24:07 volumio volumio[887]: info: Adding Item to queue: music-library/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve Apr 02 20:24:07 volumio volumio[887]: info: Exploding uri music-library/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve in service mpd Apr 02 20:24:07 volumio volumio[887]: info: Apr 02 20:24:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:07 volumio volumio[887]: info: sendMpdCommand stop took 15 milliseconds Apr 02 20:24:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:07 volumio volumio[887]: info: Apr 02 20:24:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:07 volumio volumio[887]: info: Apr 02 20:24:07 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 02 20:24:07 volumio volumio[887]: info: ControllerMpd::getState Apr 02 20:24:07 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F01%20-%20'Round%20Midnight.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/01 - 'Round Midnight.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F02%20-%20How%20About%20You.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/02 - How About You.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F03%20-%20Spartacus%20Love%20Theme.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/03 - Spartacus Love Theme.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F04%20-%20Blue%20Monk.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/04 - Blue Monk.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F05%20-%20Stella%20by%20Starlight.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/05 - Stella by Starlight.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F06%20-%20Hey%2C%20There.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/06 - Hey, There.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F07%20-%20N.Y.C.'s%20No%20Lark.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/07 - N.Y.C.'s No Lark.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F08%20-%20Just%20You%2C%20Just%20Me.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/08 - Just You, Just Me.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F09%20-%20Bemsha%20Swing.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/09 - Bemsha Swing.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2F10%20-%20A%20Sleepin'%20Bee.flac&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/10 - A Sleepin' Bee.flac Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2FConversations%20with%20Myself.cue&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/Conversations with Myself.cue Apr 02 20:24:07 volumio volumio[887]: info: ALBUMART /albumart?cacheid=175&web=Bill%20Evans/Conversations%20with%20Myself/small&path=%2Fmnt%2FUSB%2FCrucial_M50%2FMusica%202024%2FBill_Evans_-_Conversations_with_Myself_1963_1984_Verve%2FConversations%20with%20Myself.cue&metadata=false Apr 02 20:24:07 volumio volumio[887]: info: URI /mnt/USB/Crucial_M50/Musica 2024/Bill_Evans_-_Conversations_with_Myself_1963_1984_Verve/Conversations with Myself.cue Apr 02 20:24:07 volumio volumio[887]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 02 20:24:07 volumio volumio[887]: Error: Unable to resolve or reject the same promise twice Apr 02 20:24:07 volumio volumio[887]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 02 20:24:07 volumio volumio[887]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 02 20:24:07 volumio volumio[887]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 02 20:24:07 volumio volumio[887]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 02 20:24:07 volumio volumio[887]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 02 20:24:07 volumio volumio[887]: at Socket.emit (events.js:315:20) Apr 02 20:24:07 volumio volumio[887]: at addChunk (internal/streams/readable.js:309:12) Apr 02 20:24:07 volumio volumio[887]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 02 20:24:07 volumio volumio[887]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 02 20:24:07 volumio volumio[887]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 02 20:24:07 volumio volumio[887]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 02 20:24:07 volumio sudo[9081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-02 20:23 Apr 02 20:24:07 volumio sudo[9081]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"