-- Logs begin at Thu 2019-02-14 19:11:59 KST, end at Tue 2025-09-02 16:37:09 KST. -- Sep 02 16:36:11 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 02 16:36:11 volumio volumio[1107]: info: CURURI: music-library/USB/01DC19762C662800/Musica_Classica Sep 02 16:36:11 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:18 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 02 16:36:18 volumio volumio[1107]: info: CURURI: music-library/USB/01DC19762C662800/Musica_Classica/Elgar Sep 02 16:36:18 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:20 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::stop Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::serviceStop Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::stop Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::saveQueue Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Sep 02 16:36:20 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:20 volumio volumio[1107]: info: Adding Item to queue: music-library/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113 Sep 02 16:36:20 volumio volumio[1107]: info: Exploding uri music-library/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113 in service mpd Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F1-Symphony%20No%201%20in%20A%20flat%20majo.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F2-Symphony%20No%201%20in%20A%20flat%20majo.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/2-Symphony No 1 in A flat majo.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F3-Symphony%20No%201%20in%20A%20flat%20majo.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/3-Symphony No 1 in A flat majo.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F4-Symphony%20No%201%20in%20A%20flat%20majo.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/4-Symphony No 1 in A flat majo.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F5-Organ%20Sonata%20in%20G%20major%20Op%202.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/5-Organ Sonata in G major Op 2.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F6-Organ%20Sonata%20in%20G%20major%20Op%202.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/6-Organ Sonata in G major Op 2.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F7-Organ%20Sonata%20in%20G%20major%20Op%202.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/7-Organ Sonata in G major Op 2.flac Sep 02 16:36:20 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=BBC%20National%20Orchestra%20of%20Wales%20%2F%20Richard%20Hickox%2C%20conductor/Elgar%3A%20Symphony%20No.%201%2C%20Op.%2055%20%2F%20Organ%20Sonata%2C%20Op.%2028/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FElgar%2FElgar-Symphony%20No.1%2COrgan%20Sonata-BBCNOOW%2CHickox-Chandos-0113%2F8-Organ%20Sonata%20in%20G%20major%20Op%202.flac&metadata=false Sep 02 16:36:20 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/8-Organ Sonata in G major Op 2.flac Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand stop took 158 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::saveQueue Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::play index 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::stop Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::play index undefined Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::clearAddPlayTracks USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand status took 99 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand stop took 50 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand status took 47 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand status took 44 milliseconds Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:20 volumio volumio[1107]: info: touch_display: Setting screensaver timeout to 0 seconds. Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:20 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand clear took 26 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 25 milliseconds Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac" Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: 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":"Concerto for Piano and Orchestra G minor I. Allegro agitato","artist":"Boris Bloch, Jonathan Darlington - Duisburg Philharmonic Orchestra","album":"Dvorak, Chopin, Tschaikowsky","uri":"USB/01DC19762C662800/Classic/Dvorak_Chopin_Tschaikowsky_24-192/01 - Concerto for Piano and Orchestra G minor I Allegro agitato.flac","trackType":"flac"} Sep 02 16:36:20 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::syncState stateService stop Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:20 volumio volumio[1107]: info: No code Sep 02 16:36:20 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:20 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 02 16:36:20 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 221ms Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 147ms Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 143ms Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:20 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:20 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:20 volumio volumio[1107]: error: updateQueue error: null Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:20 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 101ms Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand add "USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac" took 104 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 39ms Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 37ms Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:20 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:20 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:20 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 111ms Sep 02 16:36:20 volumio volumio[1107]: info: sendMpdCommand play took 97 milliseconds Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 94ms Sep 02 16:36:20 volumio volumio[1107]: info: ------------------------------ 93ms Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:20 volumio volumio[1107]: info: Sep 02 16:36:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:20 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:21 volumio volumio[1107]: info: Sep 02 16:36:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand status took 147 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand status took 150 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand status took 148 milliseconds Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:21 volumio volumio[1107]: info: Sep 02 16:36:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:21 volumio volumio[1107]: info: Sep 02 16:36:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand status took 79 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 75 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 73 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 70 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand status took 53 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand status took 48 milliseconds Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1164,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5,"duration":1164,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"182 Kbps","isStreaming":false,"title":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":1164,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"182 Kbps","isStreaming":false,"title":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: ------------------------------ 350ms Sep 02 16:36:21 volumio volumio[1107]: info: ------------------------------ 387ms Sep 02 16:36:21 volumio volumio[1107]: info: ------------------------------ 386ms Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 251 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 240 milliseconds Sep 02 16:36:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 241 milliseconds Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":674,"duration":1164,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1708 Kbps","isStreaming":false,"title":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":674,"duration":1164,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1708 Kbps","isStreaming":false,"title":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":674,"duration":1164,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1708 Kbps","isStreaming":false,"title":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:21 volumio volumio[1107]: info: ------------------------------ 442ms Sep 02 16:36:21 volumio volumio[1107]: info: ------------------------------ 409ms Sep 02 16:36:21 volumio volumio[1107]: info: ------------------------------ 413ms Sep 02 16:36:22 volumio volumio[1107]: info: touch_display: Setting screensaver timeout to 0 seconds. Sep 02 16:36:28 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 16:36:28 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 16:36:28 volumio volumio[1107]: info: Discovery: Getting this device information Sep 02 16:36:28 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Sep 02 16:36:28 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:28 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 16:36:44 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 02 16:36:44 volumio volumio[1107]: info: CURURI: music-library/USB/01DC19762C662800/Musica_Classica/Haydn Sep 02 16:36:44 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:49 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::serviceStop Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::stop Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::saveQueue Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Sep 02 16:36:49 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:36:49 volumio volumio[1107]: info: Adding Item to queue: music-library/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock Sep 02 16:36:49 volumio volumio[1107]: info: Exploding uri music-library/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock in service mpd Sep 02 16:36:49 volumio volumio[1107]: info: Sep 02 16:36:49 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand stop took 67 milliseconds Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:49 volumio volumio[1107]: info: Sep 02 16:36:49 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:49 volumio volumio[1107]: info: Sep 02 16:36:49 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:49 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=Trevor%20Pinnock.%20The%20Engllish%20Concert/Haydn%20-%20Concertos%20for%20Oboe%2C%20Trumpet%2C%20Harpsichord/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FHaydn%2FHaydn%20-%20Concertos%20Oboe%2C%20Trumpet%2C%20Harpsichord%20-%20Pinnock%2FCDImage.flac&metadata=false Sep 02 16:36:49 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand status took 24 milliseconds Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand status took 19 milliseconds Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand status took 18 milliseconds Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::saveQueue Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::play index 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::play index undefined Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::clearAddPlayTracks USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 31 milliseconds Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 02 16:36:49 volumio volumio[1107]: info: sendMpdCommand stop took 9 milliseconds Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:49 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: 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":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:49 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::syncState stateService stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: No code Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: 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":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:49 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::syncState stateService stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: No code Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: 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":"Symphony No. 1 in A flat major, Op. 55: I. Andante. Nobilmente e semplice - Allegro - Poco meno mosso - Poco piu mosso - Tempo I - Poco animato - Grandioso (Tempo I) - Meno Mosso - Poco piu mosso - Tempo I - Poco meno mosso","artist":"BBC National Orchestra of Wales / Richard Hickox, conductor","album":"Elgar: Symphony No. 1, Op. 55 / Organ Sonata, Op. 28","uri":"USB/01DC19762C662800/Musica_Classica/Elgar/Elgar-Symphony No.1,Organ Sonata-BBCNOOW,Hickox-Chandos-0113/1-Symphony No 1 in A flat majo.flac","trackType":"flac"} Sep 02 16:36:49 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::syncState stateService stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: No code Sep 02 16:36:49 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:49 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:49 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:49 volumio volumio[1107]: info: ------------------------------ 229ms Sep 02 16:36:49 volumio volumio[1107]: info: ------------------------------ 226ms Sep 02 16:36:49 volumio volumio[1107]: info: ------------------------------ 228ms Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:50 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand clear took 311 milliseconds Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac" Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:50 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:50 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:50 volumio volumio[1107]: error: updateQueue error: null Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:50 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 228ms Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand add "USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac" took 225 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 215ms Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 212ms Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:50 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Sep 02 16:36:50 volumio volumio[1107]: info: Ignoring MPD Status Update Sep 02 16:36:50 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 38ms Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand play took 36 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 35ms Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 35ms Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:50 volumio volumio[1107]: info: touch_display: Setting screensaver timeout to 0 seconds. Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand status took 202 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand status took 206 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand status took 202 milliseconds Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:50 volumio volumio[1107]: info: Sep 02 16:36:50 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::getState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand status took 64 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 59 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 54 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 53 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand status took 48 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand status took 45 milliseconds Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseState Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3379,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.flac","artist":"Trevor Pinnock. The Engllish Concert","album":"Haydn - Concertos for Oboe, Trumpet, Harpsichord","uri":"USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac","trackType":"flac"} Sep 02 16:36:50 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":3379,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"CDImage.flac","artist":"Trevor Pinnock. The Engllish Concert","album":"Haydn - Concertos for Oboe, Trumpet, Harpsichord","uri":"USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac","trackType":"flac"} Sep 02 16:36:50 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:50 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":617,"duration":3379,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"CDImage.flac","artist":"Trevor Pinnock. The Engllish Concert","album":"Haydn - Concertos for Oboe, Trumpet, Harpsichord","uri":"USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac","trackType":"flac"} Sep 02 16:36:50 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:50 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 358ms Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 424ms Sep 02 16:36:50 volumio volumio[1107]: info: ------------------------------ 424ms Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 261 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 257 milliseconds Sep 02 16:36:50 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 262 milliseconds Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:50 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Sep 02 16:36:50 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":3379,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"597 Kbps","isStreaming":false,"title":"CDImage.flac","artist":"Trevor Pinnock. The Engllish Concert","album":"Haydn - Concertos for Oboe, Trumpet, Harpsichord","uri":"USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac","trackType":"flac"} Sep 02 16:36:50 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:50 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:50 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:50 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:50 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:51 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":800,"duration":3379,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"546 Kbps","isStreaming":false,"title":"CDImage.flac","artist":"Trevor Pinnock. The Engllish Concert","album":"Haydn - Concertos for Oboe, Trumpet, Harpsichord","uri":"USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac","trackType":"flac"} Sep 02 16:36:51 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:51 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:51 volumio volumio[1107]: info: ControllerMpd::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":800,"duration":3379,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"505 Kbps","isStreaming":false,"title":"CDImage.flac","artist":"Trevor Pinnock. The Engllish Concert","album":"Haydn - Concertos for Oboe, Trumpet, Harpsichord","uri":"USB/01DC19762C662800/Musica_Classica/Haydn/Haydn - Concertos Oboe, Trumpet, Harpsichord - Pinnock/CDImage.flac","trackType":"flac"} Sep 02 16:36:51 volumio volumio[1107]: verbose: CURRENT POSITION 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Sep 02 16:36:51 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:51 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:36:51 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:51 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:36:51 volumio volumio[1107]: info: ------------------------------ 603ms Sep 02 16:36:51 volumio volumio[1107]: info: ------------------------------ 579ms Sep 02 16:36:51 volumio volumio[1107]: info: ------------------------------ 578ms Sep 02 16:36:51 volumio volumio[1107]: info: touch_display: Setting screensaver timeout to 0 seconds. Sep 02 16:36:58 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 16:36:58 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 16:36:58 volumio volumio[1107]: info: Discovery: Getting this device information Sep 02 16:36:58 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Sep 02 16:36:58 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:36:58 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 16:37:07 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:37:07 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::stop Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Sep 02 16:37:07 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::pushState Sep 02 16:37:07 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:37:07 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 16:37:07 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::serviceStop Sep 02 16:37:07 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Sep 02 16:37:07 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Sep 02 16:37:07 volumio volumio[1107]: info: ControllerMpd::stop Sep 02 16:37:07 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 16:37:07 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Sep 02 16:37:07 volumio volumio[1107]: info: CorePlayQueue::saveQueue Sep 02 16:37:07 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Sep 02 16:37:07 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Sep 02 16:37:07 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Sep 02 16:37:07 volumio volumio[1107]: info: Preload queue cleared Sep 02 16:37:07 volumio volumio[1107]: info: Adding Item to queue: music-library/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn String Quartets(Kodaly Quartet，NAXOS，DDD) 17cd Sep 02 16:37:07 volumio volumio[1107]: info: Exploding uri music-library/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn String Quartets(Kodaly Quartet，NAXOS，DDD) 17cd in service mpd Sep 02 16:37:07 volumio volumio[1107]: info: Sep 02 16:37:07 volumio volumio[1107]: ---------------------------- MPD announces state update: player Sep 02 16:37:07 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=Kodaly%20Quartet/Haydn%20String%20Quartets/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FHaydn%2FHaydn%20String%20Quartets(Kodaly%20Quartet%EF%BC%8CNAXOS%EF%BC%8CDDD)%2017cd%2FOp.1%201-4.ape&metadata=false Sep 02 16:37:07 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn String Quartets(Kodaly Quartet，NAXOS，DDD) 17cd/Op.1 1-4.ape Sep 02 16:37:07 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=Kodaly%20Quartet/Haydn%20String%20Quartets/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FHaydn%2FHaydn%20String%20Quartets(Kodaly%20Quartet%EF%BC%8CNAXOS%EF%BC%8CDDD)%2017cd%2FOp.1%201-4.cue&metadata=false Sep 02 16:37:07 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn String Quartets(Kodaly Quartet，NAXOS，DDD) 17cd/Op.1 1-4.cue Sep 02 16:37:07 volumio volumio[1107]: info: ALBUMART /albumart?cacheid=884&web=Kodaly%20Quartet/Haydn%20String%20Quartets/extralarge&path=%2Fmnt%2FUSB%2F01DC19762C662800%2FMusica_Classica%2FHaydn%2FHaydn%20String%20Quartets(Kodaly%20Quartet%EF%BC%8CNAXOS%EF%BC%8CDDD)%2017cd%2FOp.1%201-4.cue&metadata=false Sep 02 16:37:07 volumio volumio[1107]: info: URI /mnt/USB/01DC19762C662800/Musica_Classica/Haydn/Haydn String Quartets(Kodaly Quartet，NAXOS，DDD) 17cd/Op.1 1-4.cue Sep 02 16:37:07 volumio volumio[1107]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 02 16:37:07 volumio volumio[1107]: Error: Unable to resolve or reject the same promise twice Sep 02 16:37:07 volumio volumio[1107]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 02 16:37:07 volumio volumio[1107]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Sep 02 16:37:07 volumio volumio[1107]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Sep 02 16:37:07 volumio volumio[1107]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Sep 02 16:37:07 volumio volumio[1107]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Sep 02 16:37:07 volumio volumio[1107]: at Socket.emit (events.js:315:20) Sep 02 16:37:07 volumio volumio[1107]: at addChunk (internal/streams/readable.js:309:12) Sep 02 16:37:07 volumio volumio[1107]: at readableAddChunk (internal/streams/readable.js:280:11) Sep 02 16:37:07 volumio volumio[1107]: at Socket.Readable.push (internal/streams/readable.js:223:10) Sep 02 16:37:07 volumio volumio[1107]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Sep 02 16:37:07 volumio volumio[1107]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 02 16:37:09 volumio sudo[2726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-02 16:36 Sep 02 16:37:09 volumio sudo[2726]: 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"