-- Logs begin at Fri 2024-04-12 17:49:11 UTC, end at Fri 2024-04-12 17:55:35 UTC. --
Apr 12 17:54:19 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 12 17:54:19 volumio volumio[885]: info: CURURI: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane
Apr 12 17:54:19 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[1] If I Should Lose You - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[2] You Go To My Head - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[3] How Deep Is The Ocean - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[4] Pent-Up House - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[5] Every Time We Say Good Bye - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[6] Diane - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[7] Skidadidlin' - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[8] Little Girl Blue - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/Chet Baker and Paul Bley - Diane.m3u8
Apr 12 17:54:19 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:19 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:19 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:19 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:19 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:19 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:19 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:19 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[1] If I Should Lose You - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[2] You Go To My Head - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[3] How Deep Is The Ocean - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B1%5D%20If%20I%20Should%20Lose%20You%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[1] If I Should Lose You - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B2%5D%20You%20Go%20To%20My%20Head%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[2] You Go To My Head - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B3%5D%20How%20Deep%20Is%20The%20Ocean%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[3] How Deep Is The Ocean - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[4] Pent-Up House - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B4%5D%20Pent-Up%20House%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[4] Pent-Up House - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[5] Every Time We Say Good Bye - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B5%5D%20Every%20Time%20We%20Say%20Good%20Bye%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[5] Every Time We Say Good Bye - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[6] Diane - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B6%5D%20Diane%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[6] Diane - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[7] Skidadidlin' - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B7%5D%20Skidadidlin'%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[7] Skidadidlin' - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[8] Little Girl Blue - Chet Baker and Paul Bley.flac in service mpd
Apr 12 17:54:19 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Chet%20Baker%20and%20Paul%20Bley/Diane/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChet%20Baker%20and%20Paul%20Bley%20-%20Diane%2F%5B8%5D%20Little%20Girl%20Blue%20-%20Chet%20Baker%20and%20Paul%20Bley.flac&metadata=false
Apr 12 17:54:19 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/[8] Little Girl Blue - Chet Baker and Paul Bley.flac
Apr 12 17:54:19 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chet Baker and Paul Bley - Diane/Chet Baker and Paul Bley - Diane.m3u8 in service mpd
Apr 12 17:54:22 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 12 17:54:22 volumio volumio[885]: info: CURURI: music-library/NAS/Public/Musica/Chris Barber
Apr 12 17:54:22 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:22 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:22 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:22 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:22 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:22 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:22 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:22 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:22 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:22 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:22 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:22 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:22 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:22 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:22 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:22 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:22 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:24 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 12 17:54:24 volumio volumio[885]: info: CURURI: music-library/NAS/Public/Musica/Chris Barber/CD1
Apr 12 17:54:25 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:25 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:25 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:25 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:25 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:25 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:25 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:25 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:25 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:25 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac
Apr 12 17:54:25 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac in service mpd
Apr 12 17:54:25 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=//extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChris%20Barber%2FCD1%2FChris%20Barber%20-%20%20Memories%20Of%20My%20Trip%20CD1.flac&metadata=false
Apr 12 17:54:25 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac
Apr 12 17:54:26 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:26 volumio volumio[885]: info:
Apr 12 17:54:26 volumio volumio[885]: [1712944466776] ---------------------------- Client requests add and Play Volumio CUE entry
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue
Apr 12 17:54:26 volumio volumio[885]: info: Adding CUE individual entry: 0 NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.cue
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioAddQueueItems
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::addQueueItems
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::addQueueItems
Apr 12 17:54:26 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:26 volumio volumio[885]: info: Adding Item to queue: cue://NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.cue@0
Apr 12 17:54:26 volumio volumio[885]: info: Exploding uri cue://NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.cue@0 in service mpd
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioPlay
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::play index 8
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::stPlaybackTimer
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::serviceStop
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::serviceStop
Apr 12 17:54:26 volumio volumio[885]: info: ControllerMpd::stop
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:54:26 volumio volumio[885]: info:
Apr 12 17:54:26 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand stop took 39 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::play index undefined
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 8
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 8
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:54:26 volumio volumio[885]: info:
Apr 12 17:54:26 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:26 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:26 volumio volumio[885]: info:
Apr 12 17:54:26 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:26 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand status took 13 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand stop took 10 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand status took 6 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand status took 3 milliseconds
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:26 volumio volumio[885]: info:
Apr 12 17:54:26 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:26 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand clear took 11 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 12 17:54:26 volumio volumio[885]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand load "NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.cue"
Apr 12 17:54:26 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:26 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 8
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 8
Apr 12 17:54:26 volumio volumio[885]: 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":"The Theme","artist":"Manhattan Jazz Quintet","album":"Take The A Train","uri":"NAS/Public/Musica/(Post-Bop) [CD] Manhattan Jazz Quintet - Take The A Train - 2004, FLAC (tracks .cue), lossless/Manhattan Jazz Quintet - Take The A Train/01 - The Theme.flac","trackType":"flac"}
Apr 12 17:54:26 volumio volumio[885]: verbose: CURRENT POSITION 8
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 8
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:26 volumio volumio[885]: info: No code
Apr 12 17:54:26 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:26 volumio volumio[885]: info: CorePlayQueue::getTrack 8
Apr 12 17:54:26 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:26 volumio volumio[885]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 17:54:26 volumio volumio[885]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 17:54:27 volumio volumio[885]: info: ------------------------------ 116ms
Apr 12 17:54:27 volumio volumio[885]: info: ------------------------------ 109ms
Apr 12 17:54:27 volumio volumio[885]: info: ------------------------------ 105ms
Apr 12 17:54:27 volumio volumio[885]: info:
Apr 12 17:54:27 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:27 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:27 volumio volumio[885]: info:
Apr 12 17:54:27 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:27 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:27 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:54:27 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:54:27 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:54:27 volumio volumio[885]: info: ------------------------------ 103ms
Apr 12 17:54:27 volumio volumio[885]: info: ------------------------------ 10ms
Apr 12 17:54:27 volumio volumio[885]: info: ------------------------------ 10ms
Apr 12 17:54:27 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:27 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:27 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:27 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:27 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:27 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:27 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:27 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:28 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:28 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:28 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:28 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:28 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:28 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:28 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:28 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:28 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:28 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:28 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:28 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:28 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:28 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:28 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:28 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:33 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:33 volumio volumio[885]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::ClearQueue
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::clearPlayQueue
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:54:33 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::addQueueItems
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::addQueueItems
Apr 12 17:54:33 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:33 volumio volumio[885]: info: Adding Item to queue: music-library/NAS/Public/Musica/Chris Barber/CD1
Apr 12 17:54:33 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Chris Barber/CD1 in service mpd
Apr 12 17:54:33 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=//extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FChris%20Barber%2FCD1%2FChris%20Barber%20-%20%20Memories%20Of%20My%20Trip%20CD1.flac&metadata=false
Apr 12 17:54:33 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac
Apr 12 17:54:33 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:54:33 volumio volumio[885]: info: CoreCommandRouter::volumioPlay
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::play index 0
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::play index undefined
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:33 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:54:33 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::clearAddPlayTracks NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:54:33 volumio volumio[885]: info: sendMpdCommand stop took 1 milliseconds
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:33 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:33 volumio volumio[885]: info: sendMpdCommand clear took 4 milliseconds
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand add "NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac"
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:33 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:33 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:33 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:33 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:33 volumio volumio[885]: info: ------------------------------ 5ms
Apr 12 17:54:33 volumio volumio[885]: info: sendMpdCommand add "NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac" took 4 milliseconds
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 17:54:33 volumio volumio[885]: info: ------------------------------ 5ms
Apr 12 17:54:33 volumio volumio[885]: info: ------------------------------ 5ms
Apr 12 17:54:33 volumio volumio[885]: info: ------------------------------ 3ms
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:33 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:33 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:33 volumio volumio[885]: info: sendMpdCommand play took 4 milliseconds
Apr 12 17:54:33 volumio volumio[885]: info: ------------------------------ 3ms
Apr 12 17:54:33 volumio volumio[885]: info: ------------------------------ 5ms
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:33 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:33 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:33 volumio volumio[885]: info:
Apr 12 17:54:33 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:33 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:33 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:34 volumio volumio[885]: info:
Apr 12 17:54:34 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand status took 204 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand status took 203 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:34 volumio volumio[885]: info:
Apr 12 17:54:34 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand status took 206 milliseconds
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:34 volumio volumio[885]: info:
Apr 12 17:54:34 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand status took 6 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"589 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:34 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"769 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:34 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:34 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: ------------------------------ 227ms
Apr 12 17:54:34 volumio volumio[885]: info: ------------------------------ 238ms
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand status took 35 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand playlistinfo took 33 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand status took 33 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand playlistinfo took 30 milliseconds
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"874 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:34 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:34 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"874 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:34 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:34 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: ------------------------------ 320ms
Apr 12 17:54:34 volumio volumio[885]: info: ------------------------------ 126ms
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand playlistinfo took 111 milliseconds
Apr 12 17:54:34 volumio volumio[885]: info: sendMpdCommand playlistinfo took 111 milliseconds
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:34 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"874 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:34 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:34 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"874 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:34 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:34 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:34 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:34 volumio volumio[885]: info: ------------------------------ 192ms
Apr 12 17:54:34 volumio volumio[885]: info: ------------------------------ 192ms
Apr 12 17:54:35 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:35 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:35 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:35 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:35 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:35 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:35 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:35 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:35 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:35 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:35 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:35 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:35 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:35 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:35 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:35 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:35 volumio volumio[885]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found
Apr 12 17:54:35 volumio volumio[885]: at SendStream.error (/volumio/node_modules/send/index.js:270:31)
Apr 12 17:54:35 volumio volumio[885]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14)
Apr 12 17:54:35 volumio volumio[885]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8)
Apr 12 17:54:35 volumio volumio[885]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3)
Apr 12 17:54:35 volumio volumio[885]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9)
Apr 12 17:54:35 volumio volumio[885]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 12 17:54:35 volumio volumio[885]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioSeek
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::seek
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: TRACKBLOCK {"uri":"mnt/NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","service":"mpd","name":"Chris Barber - Memories Of My Trip CD1.flac","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=718&web=//extralarge&path=%2FNAS%2FPublic%2FMusica%2FChris%20Barber%2FCD1&metadata=false","duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2}
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::seek
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: error: null
Apr 12 17:54:37 volumio volumio[885]: info:
Apr 12 17:54:37 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:37 volumio volumio[885]: info:
Apr 12 17:54:37 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:37 volumio volumio[885]: info:
Apr 12 17:54:37 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:37 volumio volumio[885]: info: sendMpdCommand status took 6 milliseconds
Apr 12 17:54:37 volumio volumio[885]: info: sendMpdCommand status took 3 milliseconds
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:37 volumio volumio[885]: info: sendMpdCommand status took 7 milliseconds
Apr 12 17:54:37 volumio volumio[885]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 12 17:54:37 volumio volumio[885]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1195000,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"868 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:37 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:37 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1195000,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"868 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:37 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:37 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: info: ------------------------------ 104ms
Apr 12 17:54:37 volumio volumio[885]: info: ------------------------------ 103ms
Apr 12 17:54:37 volumio volumio[885]: info: sendMpdCommand playlistinfo took 88 milliseconds
Apr 12 17:54:37 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:37 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1195000,"duration":4649,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"868 Kbps","isStreaming":false,"title":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:37 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:37 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:37 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:37 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:37 volumio volumio[885]: info: ------------------------------ 138ms
Apr 12 17:54:44 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::ClearQueue
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::stPlaybackTimer
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::serviceStop
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::serviceStop
Apr 12 17:54:44 volumio volumio[885]: info: ControllerMpd::stop
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::clearPlayQueue
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::addQueueItems
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::addQueueItems
Apr 12 17:54:44 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:44 volumio volumio[885]: info: Adding Item to queue: music-library/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr
Apr 12 17:54:44 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr in service mpd
Apr 12 17:54:44 volumio volumio[885]: info:
Apr 12 17:54:44 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F01-It_s_A_Blue_World-Forrest-%231-5_RVG%2C_Aug_12%2C_1959%2C_Hackensack%2C_NJ.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F02-I_Want_To_Be_Loved-S.Churchill-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/02-I_Want_To_Be_Loved-S.Churchill-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F03-Red_Beans-Red_Garland-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/03-Red_Beans-Red_Garland-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F04-Bean_s_Blues-Doug_Watkins-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/04-Bean_s_Blues-Doug_Watkins-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F05-Blues_For_Ron-Doug_Watkins-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/05-Blues_For_Ron-Doug_Watkins-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F06-For_You%2C_For_Me%2C_Forevermore-G_and_I_Gershwin-%236-13_RVG%2C_Jan_29%2C_1960%2C_Englewood_Cliffs%2C_NJ.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/06-For_You,_For_Me,_Forevermore-G_and_I_Gershwin-#6-13_RVG,_Jan_29,_1960,_Englewood_Cliffs,_NJ.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F07-While_We_re_Young-Engvick-Palitz-Wilder-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/07-While_We_re_Young-Engvick-Palitz-Wilder-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F08-Then_I_ll_Be_Tired_Of_You-Harburg-Schwartz-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/08-Then_I_ll_Be_Tired_Of_You-Harburg-Schwartz-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F09-Mighty_Like_A_Rose-Nevin-Stanton-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/09-Mighty_Like_A_Rose-Nevin-Stanton-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F10-At_Downing-C.W.Cadman-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/10-At_Downing-C.W.Cadman-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F11-Trouble_Is_A_Man-Alec_Wilder-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/11-Trouble_Is_A_Man-Alec_Wilder-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F12-Poor_Butterfly-Golden-Hubbell-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/12-Poor_Butterfly-Golden-Hubbell-.flac
Apr 12 17:54:44 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Coleman%20Hawkins%20ts%3B%20%231-5%3A%20Red%20Garland%20p%2CDoug%20Watkins%20b%2CCharles%20Specs%20Wright%20dr%3B%20%236-13%3ATommy%20Flanagan%20p%2CWendell%20Marshall%20b%2C%20Osie%20Johnson%20dr/Coleman%20Hawkins%20With%20The%20Red%20Garland%20Trio/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FColeman_Hawkins_ts_%231-5_Red_Garland_p%2CDoug_Watkins_b%2CCharles_Specs_Wright_dr_%236-13_Tommy_Flanagan_p%2CWendell_Marshall_b%2C_Osie_Johnson_dr%2F2013-Coleman_Hawkins_With_The_Red_Garland_Trio%2F13-I_ll_Get_By-Ahlert-Turk-.flac&metadata=false
Apr 12 17:54:44 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/13-I_ll_Get_By-Ahlert-Turk-.flac
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand stop took 78 milliseconds
Apr 12 17:54:44 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::volumioPlay
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::play index 0
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::play index undefined
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:54:44 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::clearAddPlayTracks NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand status took 32 milliseconds
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand stop took 2 milliseconds
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 17:54:44 volumio volumio[885]: info:
Apr 12 17:54:44 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:44 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:44 volumio volumio[885]: info:
Apr 12 17:54:44 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:44 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:44 volumio volumio[885]: info:
Apr 12 17:54:44 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:44 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand clear took 7 milliseconds
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand status took 3 milliseconds
Apr 12 17:54:44 volumio volumio[885]: info: sendMpdCommand status took 2 milliseconds
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand add "NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac"
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:44 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:44 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:44 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:44 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: 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":"Chris Barber - Memories Of My Trip CD1.flac","artist":null,"album":null,"uri":"NAS/Public/Musica/Chris Barber/CD1/Chris Barber - Memories Of My Trip CD1.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: No code
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: 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 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: No code
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: 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 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: No code
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 123ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 77ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 76ms
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:45 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:45 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:45 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:45 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 102ms
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand add "NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac" took 100 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 11ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 10ms
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:45 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:54:45 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 26ms
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand play took 23 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 21ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 20ms
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand status took 493 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand status took 491 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand status took 490 milliseconds
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:45 volumio volumio[885]: info:
Apr 12 17:54:45 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand status took 22 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand playlistinfo took 24 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand playlistinfo took 23 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand status took 20 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand status took 14 milliseconds
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":484,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":484,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:45 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":484,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:45 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 555ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 570ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 571ms
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand playlistinfo took 66 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand playlistinfo took 65 milliseconds
Apr 12 17:54:45 volumio volumio[885]: info: sendMpdCommand playlistinfo took 66 milliseconds
Apr 12 17:54:45 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":484,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:45 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":484,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:45 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":484,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:54:45 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:54:45 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:54:45 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:54:45 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 159ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 154ms
Apr 12 17:54:45 volumio volumio[885]: info: ------------------------------ 154ms
Apr 12 17:54:48 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 12 17:54:48 volumio volumio[885]: info: CURURI: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]
Apr 12 17:54:49 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/01. Diana Krall - Where Or When (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/02. Diana Krall - Too Marvelous For Words (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/03. Diana Krall - I've Grown Accustomed To His Face (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/04. Diana Krall - The Boy From Ipanema (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/05. Diana Krall - Walk On By (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/06. Diana Krall - You're My Thrill (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/07. Diana Krall - Este Seu Olhar (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/08. Diana Krall - So Nice (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/09. Diana Krall - Quiet Nights (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/10. Diana Krall - Guess I'll Hang My Tears Out To Dry (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/11. Diana Krall - How Can You Mend A Broken Heart (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/12. Diana Krall - Everytime We Say Goodbye (Album Version).flac
Apr 12 17:54:49 volumio volumio[885]: info: Preloading song: music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/PlayMe.m3u8
Apr 12 17:54:49 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/01. Diana Krall - Where Or When (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/05. Diana Krall - Walk On By (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/02. Diana Krall - Too Marvelous For Words (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/03. Diana Krall - I've Grown Accustomed To His Face (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/04. Diana Krall - The Boy From Ipanema (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/06. Diana Krall - You're My Thrill (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/07. Diana Krall - Este Seu Olhar (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/08. Diana Krall - So Nice (Album Version).flac in service mpd
Apr 12 17:54:50 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/09. Diana Krall - Quiet Nights (Album Version).flac in service mpd
Apr 12 17:54:51 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/10. Diana Krall - Guess I'll Hang My Tears Out To Dry (Album Version).flac in service mpd
Apr 12 17:54:51 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/11. Diana Krall - How Can You Mend A Broken Heart (Album Version).flac in service mpd
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F01.%20Diana%20Krall%20-%20Where%20Or%20When%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/01. Diana Krall - Where Or When (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F05.%20Diana%20Krall%20-%20Walk%20On%20By%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/05. Diana Krall - Walk On By (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F02.%20Diana%20Krall%20-%20Too%20Marvelous%20For%20Words%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/02. Diana Krall - Too Marvelous For Words (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F03.%20Diana%20Krall%20-%20I've%20Grown%20Accustomed%20To%20His%20Face%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/03. Diana Krall - I've Grown Accustomed To His Face (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F04.%20Diana%20Krall%20-%20The%20Boy%20From%20Ipanema%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/04. Diana Krall - The Boy From Ipanema (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F06.%20Diana%20Krall%20-%20You're%20My%20Thrill%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/06. Diana Krall - You're My Thrill (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F07.%20Diana%20Krall%20-%20Este%20Seu%20Olhar%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/07. Diana Krall - Este Seu Olhar (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F08.%20Diana%20Krall%20-%20So%20Nice%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/08. Diana Krall - So Nice (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F09.%20Diana%20Krall%20-%20Quiet%20Nights%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/09. Diana Krall - Quiet Nights (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F10.%20Diana%20Krall%20-%20Guess%20I'll%20Hang%20My%20Tears%20Out%20To%20Dry%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/10. Diana Krall - Guess I'll Hang My Tears Out To Dry (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F11.%20Diana%20Krall%20-%20How%20Can%20You%20Mend%20A%20Broken%20Heart%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/11. Diana Krall - How Can You Mend A Broken Heart (Album Version).flac
Apr 12 17:54:51 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/12. Diana Krall - Everytime We Say Goodbye (Album Version).flac in service mpd
Apr 12 17:54:51 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/PlayMe.m3u8 in service mpd
Apr 12 17:54:51 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Diana%20Krall/Quiet%20Nights/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDiana%20Krall%20-%20Quiet%20Nights%20(2008%20-%20Vocal%20jazz)%20%5BFlac%2024-96%5D%2F12.%20Diana%20Krall%20-%20Everytime%20We%20Say%20Goodbye%20(Album%20Version).flac&metadata=false
Apr 12 17:54:51 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Diana Krall - Quiet Nights (2008 - Vocal jazz) [Flac 24-96]/12. Diana Krall - Everytime We Say Goodbye (Album Version).flac
Apr 12 17:55:03 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::ClearQueue
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::stPlaybackTimer
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::serviceStop
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::serviceStop
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::stop
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::clearPlayQueue
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::addQueueItems
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::addQueueItems
Apr 12 17:55:03 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:55:03 volumio volumio[885]: info: Adding Item to queue: music-library/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]
Apr 12 17:55:03 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64] in service mpd
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F01%20-%20I%20Can't%20Get%20Started.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F02%20-%20Cong-Go.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F03%20-%20Body%20and%20Soul.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/03 - Body and Soul.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F04%20-%20Blues%20for%20Jerry.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/04 - Blues for Jerry.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F05%20-%20Fontainebleau%20Forest.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/05 - Fontainebleau Forest.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F06%20-%20Summertime.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/06 - Summertime.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F07%20-%20It's%20Bad%20to%20Be%20Forgotten.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/07 - It's Bad to Be Forgotten.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F08%20-%20A%20Hundred%20Dreams%20Ago.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/08 - A Hundred Dreams Ago.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F09%20-%20So.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/09 - So.dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F10%20-%20Searching%20(Pleading%20for%20Love).dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/10 - Searching (Pleading for Love).dsf
Apr 12 17:55:03 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D%2F11%20-%20Springtime%20In%20Africa.dsf&metadata=false
Apr 12 17:55:03 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/11 - Springtime In Africa.dsf
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand stop took 187 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPlay
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::play index 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::play index undefined
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::clearAddPlayTracks NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand status took 29 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand stop took 16 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand status took 15 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand status took 13 milliseconds
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:03 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand playlistinfo took 16 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand clear took 16 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand playlistinfo took 16 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand playlistinfo took 13 milliseconds
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand add "NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf"
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: 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":"It's A Blue World (Forrest) - #1-5: RVG, Aug 12, 1959, Hackensack, NJ","artist":"Coleman Hawkins ts; #1-5: Red Garland p,Doug Watkins b,Charles Specs Wright dr; #6-13:Tommy Flanagan p,Wendell Marshall b, Osie Johnson dr","album":"Coleman Hawkins With The Red Garland Trio","uri":"NAS/Public/Musica/Coleman_Hawkins_ts_#1-5_Red_Garland_p,Doug_Watkins_b,Charles_Specs_Wright_dr_#6-13_Tommy_Flanagan_p,Wendell_Marshall_b,_Osie_Johnson_dr/2013-Coleman_Hawkins_With_The_Red_Garland_Trio/01-It_s_A_Blue_World-Forrest-#1-5_RVG,_Aug_12,_1959,_Hackensack,_NJ.flac","trackType":"flac"}
Apr 12 17:55:03 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:03 volumio volumio[885]: info: No code
Apr 12 17:55:03 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:03 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:03 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:03 volumio volumio[885]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 17:55:03 volumio volumio[885]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 102ms
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 77ms
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 75ms
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:03 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:03 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:03 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:03 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 73ms
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand add "NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf" took 70 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 27ms
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 24ms
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:03 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:03 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 23ms
Apr 12 17:55:03 volumio volumio[885]: info: sendMpdCommand play took 19 milliseconds
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 19ms
Apr 12 17:55:03 volumio volumio[885]: info: ------------------------------ 18ms
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:03 volumio volumio[885]: info:
Apr 12 17:55:03 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:03 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:03 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:04 volumio volumio[885]: info:
Apr 12 17:55:04 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand status took 257 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand status took 261 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand status took 256 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand status took 4 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:04 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:55:04 volumio volumio[885]: info: ------------------------------ 271ms
Apr 12 17:55:04 volumio volumio[885]: info:
Apr 12 17:55:04 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:04 volumio volumio[885]: info:
Apr 12 17:55:04 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand status took 7 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand status took 6 milliseconds
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:04 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:04 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:04 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:04 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:04 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:04 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: ------------------------------ 409ms
Apr 12 17:55:04 volumio volumio[885]: info: ------------------------------ 408ms
Apr 12 17:55:04 volumio volumio[885]: info: ------------------------------ 158ms
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand playlistinfo took 137 milliseconds
Apr 12 17:55:04 volumio volumio[885]: info: sendMpdCommand playlistinfo took 136 milliseconds
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:04 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:04 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:04 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:04 volumio volumio[885]: verbose: CURRENT POSITION 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:04 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:04 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:04 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:04 volumio volumio[885]: info: ------------------------------ 323ms
Apr 12 17:55:04 volumio volumio[885]: info: ------------------------------ 324ms
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioNext
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::next
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::stPlaybackTimer
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::serviceStop
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 0
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::serviceStop
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::stop
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand stop took 15 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::play index undefined
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::clearAddPlayTracks NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 21 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand stop took 12 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 6 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 3 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:09 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand clear took 7 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand add "NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf"
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: 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":"I Can't Get Started","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/01 - I Can't Get Started.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService stop
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: No code
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 96ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 79ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 76ms
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:09 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:09 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:09 volumio volumio[885]: error: updateQueue error: null
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:09 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 76ms
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand add "NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf" took 72 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 19ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 19ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 17ms
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand play took 17 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:09 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces system playlist update
Apr 12 17:55:09 volumio volumio[885]: info: Ignoring MPD Status Update
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 10ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 3ms
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 209 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 211 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 209 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 4 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 226ms
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info:
Apr 12 17:55:09 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 22 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 21 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:09 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:09 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:09 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 299ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 95ms
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 73 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand status took 72 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 26 milliseconds
Apr 12 17:55:09 volumio volumio[885]: info: sendMpdCommand playlistinfo took 27 milliseconds
Apr 12 17:55:09 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":381,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:09 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":387,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:09 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:09 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:09 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:09 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 158ms
Apr 12 17:55:09 volumio volumio[885]: info: ------------------------------ 151ms
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioSeek
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::seek
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: TRACKBLOCK {"uri":"mnt/NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","service":"mpd","name":"2 - Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=718&web=Duke%20Ellington/Piano%20in%20the%20Foreground/extralarge&path=%2FNAS%2FPublic%2FMusica%2FDuke%20Ellington%20-%20Piano%20In%20The%20Foreground%20(1961)%20%5B2016_AcousticSounds%20DSD64%5D&metadata=false","duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","trackType":"dsf","channels":2}
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::startPlaybackTimer
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::seek
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: error: null
Apr 12 17:55:12 volumio volumio[885]: info:
Apr 12 17:55:12 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:12 volumio volumio[885]: info:
Apr 12 17:55:12 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:12 volumio volumio[885]: info:
Apr 12 17:55:12 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::getState
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 17:55:12 volumio volumio[885]: info: sendMpdCommand status took 13 milliseconds
Apr 12 17:55:12 volumio volumio[885]: info: sendMpdCommand status took 14 milliseconds
Apr 12 17:55:12 volumio volumio[885]: info: sendMpdCommand status took 12 milliseconds
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::parseState
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 17:55:12 volumio volumio[885]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 12 17:55:12 volumio volumio[885]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 12 17:55:12 volumio volumio[885]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 12 17:55:12 volumio volumio[885]: verbose: ControllerMpd::parseTrackInfo
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97000,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:12 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:12 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97000,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:12 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:12 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: info: ControllerMpd::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::servicePushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97000,"duration":258,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Cong-go","artist":"Duke Ellington","album":"Piano in the Foreground","uri":"NAS/Public/Musica/Duke Ellington - Piano In The Foreground (1961) [2016_AcousticSounds DSD64]/02 - Cong-Go.dsf","trackType":"dsf"}
Apr 12 17:55:12 volumio volumio[885]: verbose: CURRENT POSITION 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::syncState stateService play
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::syncState currentStatus play
Apr 12 17:55:12 volumio volumio[885]: info: Received an update from plugin. extracting info from payload
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:12 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:12 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:12 volumio volumio[885]: info: ------------------------------ 136ms
Apr 12 17:55:12 volumio volumio[885]: info: ------------------------------ 136ms
Apr 12 17:55:12 volumio volumio[885]: info: ------------------------------ 135ms
Apr 12 17:55:34 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:55:34 volumio volumio[885]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::ClearQueue
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::stop
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::stPlaybackTimer
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::updateTrackBlock
Apr 12 17:55:34 volumio volumio[885]: info: CorePlayQueue::getTrackBlock
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::pushState
Apr 12 17:55:34 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:34 volumio volumio[885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 17:55:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushState
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::serviceStop
Apr 12 17:55:34 volumio volumio[885]: info: CorePlayQueue::getTrack 1
Apr 12 17:55:34 volumio volumio[885]: info: CoreCommandRouter::serviceStop
Apr 12 17:55:34 volumio volumio[885]: info: ControllerMpd::stop
Apr 12 17:55:34 volumio volumio[885]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 17:55:34 volumio volumio[885]: info: CorePlayQueue::clearPlayQueue
Apr 12 17:55:34 volumio volumio[885]: info: CorePlayQueue::saveQueue
Apr 12 17:55:34 volumio volumio[885]: info: CoreCommandRouter::volumioPushQueue
Apr 12 17:55:34 volumio volumio[885]: info: CoreStateMachine::addQueueItems
Apr 12 17:55:34 volumio volumio[885]: info: CorePlayQueue::addQueueItems
Apr 12 17:55:34 volumio volumio[885]: info: Preload queue cleared
Apr 12 17:55:34 volumio volumio[885]: info: Adding Item to queue: music-library/NAS/Public/Musica/FIM Super Sounds (XRCD24)
Apr 12 17:55:34 volumio volumio[885]: info: Exploding uri music-library/NAS/Public/Musica/FIM Super Sounds (XRCD24) in service mpd
Apr 12 17:55:34 volumio volumio[885]: info:
Apr 12 17:55:34 volumio volumio[885]: ---------------------------- MPD announces state update: player
Apr 12 17:55:34 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=//extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FFIM%20Super%20Sounds%20(XRCD24)%2FFIM%20Super%20Sound%20(XRCD24).ape&metadata=false
Apr 12 17:55:34 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/FIM Super Sounds (XRCD24)/FIM Super Sound (XRCD24).ape
Apr 12 17:55:34 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=/FIM%20Super%20Sound%20(XRCD24)/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FFIM%20Super%20Sounds%20(XRCD24)%2FFIM%20Super%20Sound%20(XRCD24).ape.cue&metadata=false
Apr 12 17:55:34 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/FIM Super Sounds (XRCD24)/FIM Super Sound (XRCD24).ape.cue
Apr 12 17:55:34 volumio volumio[885]: info: ALBUMART /albumart?cacheid=718&web=/FIM%20Super%20Sound%20(XRCD24)/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FMusica%2FFIM%20Super%20Sounds%20(XRCD24)%2FFIM%20Super%20Sound%20(XRCD24).ape.cue&metadata=false
Apr 12 17:55:34 volumio volumio[885]: info: URI /mnt/NAS/Public/Musica/FIM Super Sounds (XRCD24)/FIM Super Sound (XRCD24).ape.cue
Apr 12 17:55:34 volumio volumio[885]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 12 17:55:34 volumio volumio[885]: Error: Unable to resolve or reject the same promise twice
Apr 12 17:55:34 volumio volumio[885]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 12 17:55:34 volumio volumio[885]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Apr 12 17:55:34 volumio volumio[885]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Apr 12 17:55:34 volumio volumio[885]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Apr 12 17:55:34 volumio volumio[885]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Apr 12 17:55:34 volumio volumio[885]: at Socket.emit (events.js:400:28)
Apr 12 17:55:34 volumio volumio[885]: at addChunk (internal/streams/readable.js:293:12)
Apr 12 17:55:34 volumio volumio[885]: at readableAddChunk (internal/streams/readable.js:263:11)
Apr 12 17:55:34 volumio volumio[885]: at Socket.Readable.push (internal/streams/readable.js:206:10)
Apr 12 17:55:34 volumio volumio[885]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Apr 12 17:55:34 volumio volumio[885]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 12 17:55:35 volumio sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-12 17:54
Apr 12 17:55:35 volumio sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET"
VOLUMIO_VERSION="3.634"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"