Oct 12 17:19:39 rivoplus volumio[3264]: info: CoreCommandRouter::volumioGetQueue Oct 12 17:19:39 rivoplus volumio[3264]: info: CoreStateMachine::getQueue Oct 12 17:19:39 rivoplus volumio[3264]: info: CorePlayQueue::getQueue Oct 12 17:19:42 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 17:19:42 rivoplus volumio[3264]: info: CURURI: music-library Oct 12 17:19:42 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:19:44 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 17:19:44 rivoplus volumio[3264]: info: CURURI: music-library/NAS Oct 12 17:19:44 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:19:45 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 17:19:45 rivoplus volumio[3264]: info: CURURI: music-library/NAS/ASUS Oct 12 17:19:45 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:19:47 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 17:19:47 rivoplus volumio[3264]: info: CURURI: music-library/NAS/ASUS/FLAC Oct 12 17:19:47 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:19:50 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 17:19:50 rivoplus volumio[3264]: info: CURURI: music-library/NAS/ASUS/FLAC/JAZZ Oct 12 17:19:50 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:19:54 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 17:19:54 rivoplus volumio[3264]: info: CURURI: music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz Oct 12 17:19:54 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:35 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::ClearQueue Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::stop Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::clearPlayQueue Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::saveQueue Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushQueue Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::addQueueItems Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::addQueueItems Oct 12 17:20:35 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:35 rivoplus volumio[3264]: info: Adding Item to queue: music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47 Oct 12 17:20:35 rivoplus volumio[3264]: info: Exploding uri music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47 in service mpd Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F01%20-%20Curtain%20Of%20The%20Rainbow.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F02%20-%20Nap.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/02 - Nap.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F03%20-%20Naanahanae.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/03 - Naanahanae.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F04%20-%20O%20Dwoch%20Takich%20Co%20Ukradli%20Ksiezyc.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/04 - O Dwoch Takich Co Ukradli Ksiezyc.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F05%20-%20A%20Poem.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/05 - A Poem.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F06%20-%20Zapomne.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/06 - Zapomne.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F07%20-%20ID.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/07 - ID.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F08%20-%20Szczypawka.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/08 - Szczypawka.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F09%20-%20Sekcja.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/09 - Sekcja.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F10%20-%20Melodia.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/10 - Melodia.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F11%20-%20Great%20Day.flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/11 - Great Day.flac Oct 12 17:20:35 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Anna%20Maria%20Jopek/Acoustic%20Room%2047/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FAnna%20Maria%20Jopek%20-%20Acoustic%20Room%2047%2F12%20-%20Glos%20W%20Fazie%20(Bonus%20Track).flac&metadata=false Oct 12 17:20:35 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/12 - Glos W Fazie (Bonus Track).flac Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushQueue Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::saveQueue Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::updateTrackBlock Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrackBlock Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPlay Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::play index 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::stop Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::play index undefined Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::startPlaybackTimer Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::clearAddPlayTracks NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand stop took 9 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:35 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand clear took 8 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand add "NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac" Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:35 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:35 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:35 rivoplus volumio[3264]: error: updateQueue error: null Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:35 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 22ms Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand add "NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac" took 19 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 16ms Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 15ms Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand play Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:35 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:35 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 19ms Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand play took 14 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 16ms Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 12ms Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand status took 20 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand status took 32 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand status took 24 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:35 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus stop Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 78ms Oct 12 17:20:35 rivoplus volumio[3264]: info: Oct 12 17:20:35 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand status took 51 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand status took 48 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand status took 5 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:35 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:35 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:35 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:35 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 257ms Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 256ms Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 178 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 178 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 174 milliseconds Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:35 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"554 Kbps","isStreaming":false,"title":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:35 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:35 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:35 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:35 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:35 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:35 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:35 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:35 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 552ms Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 549ms Oct 12 17:20:35 rivoplus volumio[3264]: info: ------------------------------ 505ms Oct 12 17:20:35 rivoplus volumio[3264]: info: Signalling Playback active due to playback status change Oct 12 17:20:36 rivoplus volumio[3264]: info: MCU Signalled Playback Active Oct 12 17:20:43 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::ClearQueue Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::stPlaybackTimer Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::updateTrackBlock Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrackBlock Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::serviceStop Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::serviceStop Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::stop Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::clearPlayQueue Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::saveQueue Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushQueue Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::addQueueItems Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::addQueueItems Oct 12 17:20:43 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:43 rivoplus volumio[3264]: info: Adding Item to queue: music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green Oct 12 17:20:43 rivoplus volumio[3264]: info: Exploding uri music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green in service mpd Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F01.%20Destination%20Moon.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F02.%20You%20Were%20Never%20Lovelier%20I'm%20old%20fashioned.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/02. You Were Never Lovelier I'm old fashioned.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F03.%20It's%20Like%20Reaching%20for%20the%20Moon.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/03. It's Like Reaching for the Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F04.%20If%20the%20Moon%20Turns%20Green.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/04. If the Moon Turns Green.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F05.%20Reaching%20for%20the%20Moon.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/05. Reaching for the Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F06.%20Quiet%20Nights%20of%20Quiet%20Stars.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/06. Quiet Nights of Quiet Stars.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F07.%20Moonlight%20Serenade.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/07. Moonlight Serenade.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F08.%20There%20Ought%20to%20Be%20a%20Moonlight%20Savings%20Time.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/08. There Ought to Be a Moonlight Savings Time.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F09.%20A%20Litte%20Girl%20a%20Little%20Boy%20a%20Little%20Moon.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/09. A Litte Girl a Little Boy a Little Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F10.%20Moon%20and%20Sand.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/10. Moon and Sand.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F11.%20Music%20in%20the%20Air%20I've%20Told%20Ev'ry%20Little%20Star.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/11. Music in the Air I've Told Ev'ry Little Star.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F12.%20A%20Handful%20of%20Stars.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/12. A Handful of Stars.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F13.%20Oh%2C%20you%20Crazy%20Moon.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/13. Oh, you Crazy Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F14.%20So%20Many%20Stars.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/14. So Many Stars.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F15.%20Fly%20Me%20to%20the%20Moon.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/15. Fly Me to the Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Diana%20Panton/If%20the%20Moon%20Turns%20Green/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FDiana%20Panton%20-%20If%20the%20Moon%20Turns%20Green%2F16.%20Moon%20River%20Breakfast%20at%20Tiffany's%20Moon%20River.flac&metadata=false Oct 12 17:20:43 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/16. Moon River Breakfast at Tiffany's Moon River.flac Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand stop took 89 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushQueue Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::saveQueue Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::updateTrackBlock Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrackBlock Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPlay Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::play index 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::play index undefined Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::startPlaybackTimer Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::clearAddPlayTracks NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 50 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand stop took 13 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:43 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand clear took 30 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 26 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 6 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand add "NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac" Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: 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":"Curtain Of The Rainbow","artist":"Anna Maria Jopek","album":"Acoustic Room 47","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Anna Maria Jopek - Acoustic Room 47/01 - Curtain Of The Rainbow.flac","trackType":"flac"} Oct 12 17:20:43 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: No code Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 17:20:43 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: No code Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 17:20:43 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus stop Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: No code Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 259ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 187ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 169ms Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:43 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:43 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:43 rivoplus volumio[3264]: error: updateQueue error: null Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:43 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 177ms Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand add "NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac" took 185 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 24ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 22ms Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand play Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:43 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces system playlist update Oct 12 17:20:43 rivoplus volumio[3264]: info: Ignoring MPD Status Update Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 138ms Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand play took 120 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 119ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 117ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: MCU Signalled Playback Inactive Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 21 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 17 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 14 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: Oct 12 17:20:43 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::getState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 26 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 23 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 9 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: info: sendMpdCommand status took 7 milliseconds Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::parseState Oct 12 17:20:43 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":533,"duration":203,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"6 Kbps","isStreaming":false,"title":"Destination Moon","artist":"Diana Panton","album":"If the Moon Turns Green","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac","trackType":"flac"} Oct 12 17:20:43 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus stop Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":628,"duration":203,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"6 Kbps","isStreaming":false,"title":"Destination Moon","artist":"Diana Panton","album":"If the Moon Turns Green","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac","trackType":"flac"} Oct 12 17:20:43 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:43 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":704,"duration":203,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"6 Kbps","isStreaming":false,"title":"Destination Moon","artist":"Diana Panton","album":"If the Moon Turns Green","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac","trackType":"flac"} Oct 12 17:20:43 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:43 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:43 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:43 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 112ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 165ms Oct 12 17:20:43 rivoplus volumio[3264]: info: ------------------------------ 165ms Oct 12 17:20:44 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 124 milliseconds Oct 12 17:20:44 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 121 milliseconds Oct 12 17:20:44 rivoplus volumio[3264]: info: sendMpdCommand playlistinfo took 122 milliseconds Oct 12 17:20:44 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:44 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:44 rivoplus volumio[3264]: verbose: ControllerMpd::parseTrackInfo Oct 12 17:20:44 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":203,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4440 Kbps","isStreaming":false,"title":"Destination Moon","artist":"Diana Panton","album":"If the Moon Turns Green","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac","trackType":"flac"} Oct 12 17:20:44 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:44 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:44 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":203,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4440 Kbps","isStreaming":false,"title":"Destination Moon","artist":"Diana Panton","album":"If the Moon Turns Green","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac","trackType":"flac"} Oct 12 17:20:44 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:44 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:44 rivoplus volumio[3264]: info: ControllerMpd::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::servicePushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":203,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4440 Kbps","isStreaming":false,"title":"Destination Moon","artist":"Diana Panton","album":"If the Moon Turns Green","uri":"NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Diana Panton - If the Moon Turns Green/01. Destination Moon.flac","trackType":"flac"} Oct 12 17:20:44 rivoplus volumio[3264]: verbose: CURRENT POSITION 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::syncState stateService play Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:20:44 rivoplus volumio[3264]: info: Received an update from plugin. extracting info from payload Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:44 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:44 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:44 rivoplus volumio[3264]: info: ------------------------------ 352ms Oct 12 17:20:44 rivoplus volumio[3264]: info: ------------------------------ 332ms Oct 12 17:20:44 rivoplus volumio[3264]: info: ------------------------------ 333ms Oct 12 17:20:44 rivoplus volumio[3264]: info: Signalling Playback active due to playback status change Oct 12 17:20:44 rivoplus volumio[3264]: info: MCU Signalled Playback Active Oct 12 17:20:53 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::ClearQueue Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::stop Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::stPlaybackTimer Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::updateTrackBlock Oct 12 17:20:53 rivoplus volumio[3264]: info: CorePlayQueue::getTrackBlock Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::pushState Oct 12 17:20:53 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushState Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::serviceStop Oct 12 17:20:53 rivoplus volumio[3264]: info: CorePlayQueue::getTrack 0 Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreCommandRouter::serviceStop Oct 12 17:20:53 rivoplus volumio[3264]: info: ControllerMpd::stop Oct 12 17:20:53 rivoplus volumio[3264]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 17:20:53 rivoplus volumio[3264]: info: CorePlayQueue::clearPlayQueue Oct 12 17:20:53 rivoplus volumio[3264]: info: CorePlayQueue::saveQueue Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreCommandRouter::volumioPushQueue Oct 12 17:20:53 rivoplus volumio[3264]: info: CoreStateMachine::addQueueItems Oct 12 17:20:53 rivoplus volumio[3264]: info: CorePlayQueue::addQueueItems Oct 12 17:20:53 rivoplus volumio[3264]: info: Preload queue cleared Oct 12 17:20:53 rivoplus volumio[3264]: info: Adding Item to queue: music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Chantal Chamberland-This is Our Time Oct 12 17:20:53 rivoplus volumio[3264]: info: Exploding uri music-library/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Chantal Chamberland-This is Our Time in service mpd Oct 12 17:20:53 rivoplus volumio[3264]: info: Oct 12 17:20:53 rivoplus volumio[3264]: ---------------------------- MPD announces state update: player Oct 12 17:20:53 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=//extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FChantal%20Chamberland-This%20is%20Our%20Time%2FCDImage.ape&metadata=false Oct 12 17:20:53 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Chantal Chamberland-This is Our Time/CDImage.ape Oct 12 17:20:53 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Chantal%20Chamberland/This%20is%20Our%20Time/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FChantal%20Chamberland-This%20is%20Our%20Time%2FCDImage.ape.cue&metadata=false Oct 12 17:20:53 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Chantal Chamberland-This is Our Time/CDImage.ape.cue Oct 12 17:20:53 rivoplus volumio[3264]: info: ALBUMART /albumart?cacheid=492&web=Chantal%20Chamberland/This%20is%20Our%20Time/extralarge&path=%2Fmnt%2FNAS%2FASUS%2FFLAC%2FJAZZ%2FVocal%20Jazz%2FChantal%20Chamberland-This%20is%20Our%20Time%2FCDImage.ape.cue&metadata=false Oct 12 17:20:53 rivoplus volumio[3264]: info: URI /mnt/NAS/ASUS/FLAC/JAZZ/Vocal Jazz/Chantal Chamberland-This is Our Time/CDImage.ape.cue Oct 12 17:20:53 rivoplus volumio[3264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 17:20:53 rivoplus volumio[3264]: Error: Unable to resolve or reject the same promise twice Oct 12 17:20:53 rivoplus volumio[3264]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 12 17:20:53 rivoplus volumio[3264]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 12 17:20:53 rivoplus volumio[3264]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 12 17:20:53 rivoplus volumio[3264]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 12 17:20:53 rivoplus volumio[3264]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 12 17:20:53 rivoplus volumio[3264]: at Socket.emit (node:events:514:28) Oct 12 17:20:53 rivoplus volumio[3264]: at addChunk (node:internal/streams/readable:343:12) Oct 12 17:20:53 rivoplus volumio[3264]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 12 17:20:53 rivoplus volumio[3264]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 17:20:53 rivoplus volumio[3264]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 12 17:20:53 rivoplus volumio[3264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 17:20:54 rivoplus sudo[5127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 17:19' Oct 12 17:20:54 rivoplus sudo[5127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:52:40 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="ba37532a86808e19439a6278b2d45f47"