-- Logs begin at Thu 2019-02-14 19:12:00 KST, end at Wed 2024-04-10 08:11:49 KST. -- Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioNext Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::next Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::stop Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::stPlaybackTimer Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::serviceStop Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::serviceStop Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::stop Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand stop took 8 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::play index undefined Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::startPlaybackTimer Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 9 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand stop took 6 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 4 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 2 milliseconds Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:13 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand clear took 4 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac" Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You and the Night and the Music","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/01 You and the Night and the Music.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService stop Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus stop Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: No code Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 08:10:13 volumio volumio[929]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 47ms Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 41ms Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 39ms Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:13 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:13 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:13 volumio volumio[929]: error: updateQueue error: null Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:13 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 40ms Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand add "NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac" took 37 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 7ms Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 6ms Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand play Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:13 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:13 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 21ms Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand play took 19 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 18ms Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 17ms Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 19 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 16 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 14 milliseconds Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: Apr 10 08:10:13 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 103 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 98 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 98 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 97 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 93 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand status took 89 milliseconds Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":365,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus stop Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":365,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:13 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":365,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:13 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 162ms Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 168ms Apr 10 08:10:13 volumio volumio[929]: info: ------------------------------ 165ms Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 53 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 51 milliseconds Apr 10 08:10:13 volumio volumio[929]: info: sendMpdCommand playlistinfo took 51 milliseconds Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":365,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"916 Kbps","isStreaming":false,"title":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:13 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":365,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1005 Kbps","isStreaming":false,"title":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:13 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:13 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":365,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1005 Kbps","isStreaming":false,"title":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:13 volumio volumio[929]: verbose: CURRENT POSITION 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:13 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:13 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:13 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:14 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:14 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:14 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:14 volumio volumio[929]: info: ------------------------------ 218ms Apr 10 08:10:14 volumio volumio[929]: info: ------------------------------ 206ms Apr 10 08:10:14 volumio volumio[929]: info: ------------------------------ 204ms Apr 10 08:10:20 volumio volumio[929]: info: Preload queue cleared Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::ClearQueue Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::stop Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::stPlaybackTimer Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::serviceStop Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 1 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::serviceStop Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::stop Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::clearPlayQueue Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::saveQueue Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushQueue Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::addQueueItems Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::addQueueItems Apr 10 08:10:20 volumio volumio[929]: info: Preload queue cleared Apr 10 08:10:20 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love Apr 10 08:10:20 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love in service mpd Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F01%20Eddie%20Higgins%20trio%20-%20Brownsburg%20Blues.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F02%20Eddie%20Higgins%20trio%20-%20Flando%20De%20Orlando.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/02 Eddie Higgins trio - Flando De Orlando.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F03%20Eddie%20Higgins%20trio%20-%20York%20Town%20Girl.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/03 Eddie Higgins trio - York Town Girl.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F04%20Eddie%20Higgins%20trio%20-%20Midnight%20At%20Maxims.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/04 Eddie Higgins trio - Midnight At Maxims.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F05%20Eddie%20Higgins%20trio%20-%20St.Louis%20Rendezvous.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/05 Eddie Higgins trio - St.Louis Rendezvous.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F06%20Eddie%20Higgins%20trio%20-%20Alice%20From%20Dallas.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/06 Eddie Higgins trio - Alice From Dallas.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F07%20Eddie%20Higgins%20trio%20-%20Chicago%20Serenade.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/07 Eddie Higgins trio - Chicago Serenade.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F08%20Eddie%20Higgins%20trio%20-%20Mar%20Descancado.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/08 Eddie Higgins trio - Mar Descancado.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F09%20Eddie%20Higgins%20trio%20-%20Moonlight%20On%20Kinkakuji.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/09 Eddie Higgins trio - Moonlight On Kinkakuji.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F10%20Eddie%20Higgins%20trio%20-%20La%20Cubana%20Caliente.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/10 Eddie Higgins trio - La Cubana Caliente.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F11%20Eddie%20Higgins%20trio%20-%20Seoul%20Music.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F12%20Eddie%20Higgins%20trio%20-%20April%20In%20Torino.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/12 Eddie Higgins trio - April In Torino.flac Apr 10 08:10:20 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eddie%20Higgins%20trio/Portraits%20Of%20Love/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEddie%20Higgins%20trio%20-%20Portraits%20Of%20Love%2F13%20Eddie%20Higgins%20trio%20-%20Anitas%20Caribbean%20Caper.flac&metadata=false Apr 10 08:10:20 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/13 Eddie Higgins trio - Anitas Caribbean Caper.flac Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand stop took 162 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushQueue Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::saveQueue Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPlay Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::play index 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::stop Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::play index undefined Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::startPlaybackTimer Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand status took 27 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand stop took 9 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand status took 5 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand status took 4 milliseconds Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:20 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand clear took 11 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac" Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: 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":"How My Heart Sings","artist":"Eddie Higgins Trio","album":"Standard Higgins","uri":"NAS/NAS/CD Ripping/Eddie Higgins Trio - Standard Higgins/02 How My Heart Sings.flac","trackType":"flac"} Apr 10 08:10:20 volumio volumio[929]: verbose: CURRENT POSITION 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState stateService stop Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus stop Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: No code Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 08:10:20 volumio volumio[929]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 77ms Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 37ms Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 33ms Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:20 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:20 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:20 volumio volumio[929]: error: updateQueue error: null Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:20 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 64ms Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand add "NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac" took 62 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 24ms Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 17ms Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand play Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:20 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:20 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 18ms Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand play took 15 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 14ms Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 12ms Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand status took 5 milliseconds Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:20 volumio volumio[929]: info: Apr 10 08:10:20 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand status took 5 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand status took 3 milliseconds Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"510 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Brownsburg Blues","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac","trackType":"flac"} Apr 10 08:10:20 volumio volumio[929]: verbose: CURRENT POSITION 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus stop Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 40ms Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand playlistinfo took 21 milliseconds Apr 10 08:10:20 volumio volumio[929]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:20 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"510 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Brownsburg Blues","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac","trackType":"flac"} Apr 10 08:10:20 volumio volumio[929]: verbose: CURRENT POSITION 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:20 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"510 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Brownsburg Blues","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac","trackType":"flac"} Apr 10 08:10:20 volumio volumio[929]: verbose: CURRENT POSITION 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:20 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:20 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:20 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 70ms Apr 10 08:10:20 volumio volumio[929]: info: ------------------------------ 68ms Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPlay Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::play index 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::stop Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::stPlaybackTimer Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::serviceStop Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::serviceStop Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::stop Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand stop took 9 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::play index undefined Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::startPlaybackTimer Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 25 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand stop took 6 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 4 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 3 milliseconds Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:37 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand clear took 8 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac" Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: 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":"Eddie Higgins trio - Brownsburg Blues","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/01 Eddie Higgins trio - Brownsburg Blues.flac","trackType":"flac"} Apr 10 08:10:37 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState stateService stop Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus stop Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: No code Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 08:10:37 volumio volumio[929]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 60ms Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 38ms Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 36ms Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:37 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:37 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:37 volumio volumio[929]: error: updateQueue error: null Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:37 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 34ms Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand add "NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac" took 31 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 9ms Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 8ms Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand play Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:37 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces system playlist update Apr 10 08:10:37 volumio volumio[929]: info: Ignoring MPD Status Update Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 22ms Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand play took 19 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 19ms Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 16ms Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 12 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 11 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 9 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 7 milliseconds Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: info: Apr 10 08:10:37 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand status took 5 milliseconds Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"568 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:37 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus stop Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"568 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:37 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:37 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"568 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:37 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:37 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"568 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:37 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:37 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 56ms Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 78ms Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 73ms Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 72ms Apr 10 08:10:37 volumio volumio[929]: info: sendMpdCommand playlistinfo took 54 milliseconds Apr 10 08:10:37 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:37 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"568 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:37 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:37 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:37 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:37 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:37 volumio volumio[929]: info: ------------------------------ 85ms Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand update Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: Apr 10 08:10:55 volumio volumio[929]: ---------------------------- MPD announces state update: update Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand update took 4 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 4 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 2 milliseconds Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: info: Command Router : Notfying DB Updatetrue Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: Apr 10 08:10:55 volumio volumio[929]: ---------------------------- MPD announces state update: update Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: Apr 10 08:10:55 volumio volumio[929]: ---------------------------- MPD announces state update: update Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 7 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 6 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 5 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 4 milliseconds Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: info: Command Router : Notfying DB Updatetrue Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::Close All Modals sent Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: info: Command Router : Notfying DB Updatetrue Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::Close All Modals sent Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18852,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"430 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:55 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:55 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: ------------------------------ 205ms Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand playlistinfo took 82 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand playlistinfo took 45 milliseconds Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19081,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"419 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:55 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:55 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19081,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"419 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:55 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:55 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: ------------------------------ 169ms Apr 10 08:10:55 volumio volumio[929]: info: ------------------------------ 169ms Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: Apr 10 08:10:55 volumio volumio[929]: ---------------------------- MPD announces state update: update Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: Apr 10 08:10:55 volumio volumio[929]: ---------------------------- MPD announces state update: update Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: Apr 10 08:10:55 volumio volumio[929]: ---------------------------- MPD announces state update: update Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::getState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand status Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 7 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 7 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 6 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 6 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 5 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand status took 4 milliseconds Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: info: Command Router : Notfying DB Updatefalse Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::Close All Modals sent Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: info: Command Router : Notfying DB Updatefalse Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::Close All Modals sent Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: info: Command Router : Notfying DB Updatefalse Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::Close All Modals sent Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseState Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand playlistinfo took 79 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand playlistinfo took 45 milliseconds Apr 10 08:10:55 volumio volumio[929]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:55 volumio volumio[929]: verbose: ControllerMpd::parseTrackInfo Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19219,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:55 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:55 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19219,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:55 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:55 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: ControllerMpd::pushState Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::servicePushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19219,"duration":418,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Eddie Higgins trio - Seoul Music","artist":"Eddie Higgins trio","album":"Portraits Of Love","uri":"NAS/NAS/CD Ripping/Eddie Higgins trio - Portraits Of Love/11 Eddie Higgins trio - Seoul Music.flac","trackType":"flac"} Apr 10 08:10:55 volumio volumio[929]: verbose: CURRENT POSITION 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState stateService play Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::syncState currentStatus play Apr 10 08:10:55 volumio volumio[929]: info: Received an update from plugin. extracting info from payload Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:10:55 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:10:55 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:10:55 volumio volumio[929]: info: ------------------------------ 165ms Apr 10 08:10:55 volumio volumio[929]: info: ------------------------------ 164ms Apr 10 08:10:55 volumio volumio[929]: info: ------------------------------ 163ms Apr 10 08:11:43 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 08:11:43 volumio volumio[929]: info: CURURI: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994 Apr 10 08:11:43 volumio volumio[929]: info: Preload queue cleared Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/01 Eagles - Get Over It.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/02 Eagles - Love Will Keep Us Alive.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/03 Eagles - The Girl From Yesterday.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/04 Eagles - Learn to Be Still.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/05 Eagles - Tequila Sunrise.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/06 Eagles - Hotel California.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/07 Eagles - Wasted Time.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/08 Eagles - Pretty Maids All In A Row.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/09 Eagles - Track 09.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/10 Eagles - New York Minute.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/11 Eagles - The Last Resort.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/12 Eagles - Take It Easy.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/13 Eagles - In The City.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/14 Eagles - Life In The Fast Lane.flac Apr 10 08:11:43 volumio volumio[929]: info: Preloading song: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/15 Eagles - Desperado.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/01 Eagles - Get Over It.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F01%20Eagles%20-%20Get%20Over%20It.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/01 Eagles - Get Over It.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/02 Eagles - Love Will Keep Us Alive.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F02%20Eagles%20-%20Love%20Will%20Keep%20Us%20Alive.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/02 Eagles - Love Will Keep Us Alive.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/03 Eagles - The Girl From Yesterday.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F03%20Eagles%20-%20The%20Girl%20From%20Yesterday.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/03 Eagles - The Girl From Yesterday.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/04 Eagles - Learn to Be Still.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F04%20Eagles%20-%20Learn%20to%20Be%20Still.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/04 Eagles - Learn to Be Still.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/05 Eagles - Tequila Sunrise.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F05%20Eagles%20-%20Tequila%20Sunrise.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/05 Eagles - Tequila Sunrise.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/06 Eagles - Hotel California.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F06%20Eagles%20-%20Hotel%20California.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/06 Eagles - Hotel California.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/07 Eagles - Wasted Time.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F07%20Eagles%20-%20Wasted%20Time.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/07 Eagles - Wasted Time.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/08 Eagles - Pretty Maids All In A Row.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F08%20Eagles%20-%20Pretty%20Maids%20All%20In%20A%20Row.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/08 Eagles - Pretty Maids All In A Row.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/09 Eagles - Track 09.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F09%20Eagles%20-%20Track%2009.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/09 Eagles - Track 09.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/10 Eagles - New York Minute.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F10%20Eagles%20-%20New%20York%20Minute.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/10 Eagles - New York Minute.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/11 Eagles - The Last Resort.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F11%20Eagles%20-%20The%20Last%20Resort.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/11 Eagles - The Last Resort.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/12 Eagles - Take It Easy.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F12%20Eagles%20-%20Take%20It%20Easy.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/12 Eagles - Take It Easy.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/13 Eagles - In The City.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F13%20Eagles%20-%20In%20The%20City.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/13 Eagles - In The City.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/14 Eagles - Life In The Fast Lane.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F14%20Eagles%20-%20Life%20In%20The%20Fast%20Lane.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/14 Eagles - Life In The Fast Lane.flac Apr 10 08:11:43 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/15 Eagles - Desperado.flac in service mpd Apr 10 08:11:43 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2F15%20Eagles%20-%20Desperado.flac&metadata=false Apr 10 08:11:43 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/15 Eagles - Desperado.flac Apr 10 08:11:49 volumio volumio[929]: info: Preload queue cleared Apr 10 08:11:49 volumio volumio[929]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::ClearQueue Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::stop Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::stPlaybackTimer Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Apr 10 08:11:49 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::pushState Apr 10 08:11:49 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:11:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 08:11:49 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::serviceStop Apr 10 08:11:49 volumio volumio[929]: info: CorePlayQueue::getTrack 10 Apr 10 08:11:49 volumio volumio[929]: info: CoreCommandRouter::serviceStop Apr 10 08:11:49 volumio volumio[929]: info: ControllerMpd::stop Apr 10 08:11:49 volumio volumio[929]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 08:11:49 volumio volumio[929]: info: CorePlayQueue::clearPlayQueue Apr 10 08:11:49 volumio volumio[929]: info: CorePlayQueue::saveQueue Apr 10 08:11:49 volumio volumio[929]: info: CoreCommandRouter::volumioPushQueue Apr 10 08:11:49 volumio volumio[929]: info: CoreStateMachine::addQueueItems Apr 10 08:11:49 volumio volumio[929]: info: CorePlayQueue::addQueueItems Apr 10 08:11:49 volumio volumio[929]: info: Preload queue cleared Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/01 Eagles - Get Over It.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/01 Eagles - Get Over It.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/02 Eagles - Love Will Keep Us Alive.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/02 Eagles - Love Will Keep Us Alive.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/03 Eagles - The Girl From Yesterday.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/03 Eagles - The Girl From Yesterday.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/04 Eagles - Learn to Be Still.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/04 Eagles - Learn to Be Still.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/05 Eagles - Tequila Sunrise.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/05 Eagles - Tequila Sunrise.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/06 Eagles - Hotel California.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/06 Eagles - Hotel California.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/07 Eagles - Wasted Time.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/07 Eagles - Wasted Time.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/08 Eagles - Pretty Maids All In A Row.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/08 Eagles - Pretty Maids All In A Row.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/09 Eagles - Track 09.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/09 Eagles - Track 09.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/10 Eagles - New York Minute.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/10 Eagles - New York Minute.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/11 Eagles - The Last Resort.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/11 Eagles - The Last Resort.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/12 Eagles - Take It Easy.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/12 Eagles - Take It Easy.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/13 Eagles - In The City.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/13 Eagles - In The City.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/14 Eagles - Life In The Fast Lane.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/14 Eagles - Life In The Fast Lane.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/15 Eagles - Desperado.flac Apr 10 08:11:49 volumio volumio[929]: info: Using cached record of: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/15 Eagles - Desperado.flac Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/Original Apr 10 08:11:49 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/Original in service mpd Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/Art Apr 10 08:11:49 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/Art in service mpd Apr 10 08:11:49 volumio volumio[929]: info: Adding Item to queue: music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/@eaDir Apr 10 08:11:49 volumio volumio[929]: info: Exploding uri music-library/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/@eaDir in service mpd Apr 10 08:11:49 volumio volumio[929]: info: Apr 10 08:11:49 volumio volumio[929]: ---------------------------- MPD announces state update: player Apr 10 08:11:49 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2FOriginal%2FEagles%20-%20Hell%20Freezes%20Over%20(GEFD-24725%20).cue&metadata=false Apr 10 08:11:49 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/Original/Eagles - Hell Freezes Over (GEFD-24725 ).cue Apr 10 08:11:49 volumio volumio[929]: info: ALBUMART /albumart?cacheid=759&web=Eagles/Hell%20Freezes%20Over%20(GEFD-24725%20)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FCD%20Ripping%2FEagles%20%E2%80%8E-%20Hell%20Freezes%20Over%20-%201994%2FOriginal%2FEagles%20-%20Hell%20Freezes%20Over%20(GEFD-24725%20).cue&metadata=false Apr 10 08:11:49 volumio volumio[929]: info: URI /mnt/NAS/NAS/CD Ripping/Eagles ‎- Hell Freezes Over - 1994/Original/Eagles - Hell Freezes Over (GEFD-24725 ).cue Apr 10 08:11:49 volumio volumio[929]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 08:11:49 volumio volumio[929]: Error: Unable to resolve or reject the same promise twice Apr 10 08:11:49 volumio volumio[929]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 10 08:11:49 volumio volumio[929]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 10 08:11:49 volumio volumio[929]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 10 08:11:49 volumio volumio[929]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 10 08:11:49 volumio volumio[929]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 10 08:11:49 volumio volumio[929]: at Socket.emit (events.js:315:20) Apr 10 08:11:49 volumio volumio[929]: at addChunk (internal/streams/readable.js:309:12) Apr 10 08:11:49 volumio volumio[929]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 10 08:11:49 volumio volumio[929]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 10 08:11:49 volumio volumio[929]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 10 08:11:49 volumio volumio[929]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 08:11:49 volumio sudo[1823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-10 08:10 Apr 10 08:11:49 volumio sudo[1823]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"