-- Logs begin at Sat 2024-04-06 01:24:02 CEST, end at Sat 2024-04-06 12:49:25 CEST. -- Apr 06 12:48:08 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 06 12:48:08 rivo volumio[5597]: info: CURURI: music-library/USB/LaCie_2/Mahler Apr 06 12:48:08 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:48:08 rivo volumio[5597]: info: Preloading song: music-library/USB/LaCie_2/Mahler/01 - 1st mvt. - Bedächtig Nicht eilen - Recht gemächlich.flac Apr 06 12:48:08 rivo volumio[5597]: info: Preloading song: music-library/USB/LaCie_2/Mahler/02 - 2nd mvt. - In gemächlicher Bewegung.flac Apr 06 12:48:08 rivo volumio[5597]: info: Preloading song: music-library/USB/LaCie_2/Mahler/03 - 3rd mvt. - Ruhevoll (Poco adagio).flac Apr 06 12:48:08 rivo volumio[5597]: info: Preloading song: music-library/USB/LaCie_2/Mahler/04 - 4th mvt. - Sehr behaglich (words from Des Knaben Wunderhorn).flac Apr 06 12:48:08 rivo volumio[5597]: info: Exploding uri music-library/USB/LaCie_2/Mahler/01 - 1st mvt. - Bedächtig Nicht eilen - Recht gemächlich.flac in service mpd Apr 06 12:48:08 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Mahler/Symphony%20No%204%20in%20G%20major/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2F01%20-%201st%20mvt.%20-%20Bed%C3%A4chtig%20Nicht%20eilen%20-%20Recht%20gem%C3%A4chlich.flac&metadata=false Apr 06 12:48:08 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/01 - 1st mvt. - Bedächtig Nicht eilen - Recht gemächlich.flac Apr 06 12:48:08 rivo volumio[5597]: info: Exploding uri music-library/USB/LaCie_2/Mahler/02 - 2nd mvt. - In gemächlicher Bewegung.flac in service mpd Apr 06 12:48:08 rivo volumio[5597]: info: Exploding uri music-library/USB/LaCie_2/Mahler/03 - 3rd mvt. - Ruhevoll (Poco adagio).flac in service mpd Apr 06 12:48:08 rivo volumio[5597]: info: Exploding uri music-library/USB/LaCie_2/Mahler/04 - 4th mvt. - Sehr behaglich (words from Des Knaben Wunderhorn).flac in service mpd Apr 06 12:48:08 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Mahler/Symphony%20No%204%20in%20G%20major/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2F02%20-%202nd%20mvt.%20-%20In%20gem%C3%A4chlicher%20Bewegung.flac&metadata=false Apr 06 12:48:08 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/02 - 2nd mvt. - In gemächlicher Bewegung.flac Apr 06 12:48:08 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Mahler/Symphony%20No%204%20in%20G%20major/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2F03%20-%203rd%20mvt.%20-%20Ruhevoll%20(Poco%20adagio).flac&metadata=false Apr 06 12:48:08 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/03 - 3rd mvt. - Ruhevoll (Poco adagio).flac Apr 06 12:48:09 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Mahler/Symphony%20No%204%20in%20G%20major/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2F04%20-%204th%20mvt.%20-%20Sehr%20behaglich%20(words%20from%20Des%20Knaben%20Wunderhorn).flac&metadata=false Apr 06 12:48:09 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/04 - 4th mvt. - Sehr behaglich (words from Des Knaben Wunderhorn).flac Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 06 12:48:10 rivo volumio[5597]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 06 12:48:10 rivo volumio[5597]: info: Received Get System Version Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 06 12:48:10 rivo volumio[5597]: info: Received Get System Info Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 06 12:48:10 rivo volumio[5597]: info: Discovery: Getting this device information Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::volumioGetState Apr 06 12:48:10 rivo volumio[5597]: info: CorePlayQueue::getTrack 2 Apr 06 12:48:10 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 06 12:48:21 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 06 12:48:21 rivo volumio[5597]: info: CURURI: music-library/USB/LaCie_2/Mahler/Herreweghe Apr 06 12:48:21 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:48:24 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::ClearQueue Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::stop Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::updateTrackBlock Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrackBlock Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::stPlaybackTimer Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 2 Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:24 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:24 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::serviceStop Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 2 Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::serviceStop Apr 06 12:48:24 rivo volumio[5597]: info: ControllerMpd::stop Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand stop Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::clearPlayQueue Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::saveQueue Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushQueue Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::addQueueItems Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::addQueueItems Apr 06 12:48:24 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:48:24 rivo volumio[5597]: info: Adding Item to queue: music-library/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM) Apr 06 12:48:24 rivo volumio[5597]: info: Exploding uri music-library/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM) in service mpd Apr 06 12:48:24 rivo volumio[5597]: info: Apr 06 12:48:24 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Birgit%20Remmert%3B%20Hans%20Peter%20Blochwitz%3B%20Ensemble%20Musique%20Oblique%3B%20Philippe%20Herreweghe/Das%20Lied%20von%20der%20Erde%20(Version%20Schoenberg-Riehn)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2FHerreweghe%2FMahler%20-%20Das%20Lied%20von%20der%20Erde%20(Herreweghe%201994%20HM)%2F01%20-%20Das%20Lied%20von%20der%20Erde%20-%20Das%20Trinklied%20vom%20Jammer%20der%20Erde.%20Allegro%20pesante.flac&metadata=false Apr 06 12:48:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac Apr 06 12:48:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Birgit%20Remmert%3B%20Hans%20Peter%20Blochwitz%3B%20Ensemble%20Musique%20Oblique%3B%20Philippe%20Herreweghe/Das%20Lied%20von%20der%20Erde%20(Version%20Schoenberg-Riehn)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2FHerreweghe%2FMahler%20-%20Das%20Lied%20von%20der%20Erde%20(Herreweghe%201994%20HM)%2F02%20-%20Das%20Lied%20von%20der%20Erde%20-%20Der%20Einsame%20im%20Herbst.%20Etwas%20Schleichend.%20Erm%C3%BCdet.flac&metadata=false Apr 06 12:48:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/02 - Das Lied von der Erde - Der Einsame im Herbst. Etwas Schleichend. Ermüdet.flac Apr 06 12:48:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Birgit%20Remmert%3B%20Hans%20Peter%20Blochwitz%3B%20Ensemble%20Musique%20Oblique%3B%20Philippe%20Herreweghe/Das%20Lied%20von%20der%20Erde%20(Version%20Schoenberg-Riehn)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2FHerreweghe%2FMahler%20-%20Das%20Lied%20von%20der%20Erde%20(Herreweghe%201994%20HM)%2F03%20-%20Das%20Lied%20von%20der%20Erde%20-%20Von%20der%20Jugend.%20Berhaglich%20heiter.flac&metadata=false Apr 06 12:48:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/03 - Das Lied von der Erde - Von der Jugend. Berhaglich heiter.flac Apr 06 12:48:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Birgit%20Remmert%3B%20Hans%20Peter%20Blochwitz%3B%20Ensemble%20Musique%20Oblique%3B%20Philippe%20Herreweghe/Das%20Lied%20von%20der%20Erde%20(Version%20Schoenberg-Riehn)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2FHerreweghe%2FMahler%20-%20Das%20Lied%20von%20der%20Erde%20(Herreweghe%201994%20HM)%2F04%20-%20Das%20Lied%20von%20der%20Erde%20-%20Von%20der%20Sch%C3%B6heit.%20Comodo.%20Dolcissimo.flac&metadata=false Apr 06 12:48:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/04 - Das Lied von der Erde - Von der Schöheit. Comodo. Dolcissimo.flac Apr 06 12:48:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Birgit%20Remmert%3B%20Hans%20Peter%20Blochwitz%3B%20Ensemble%20Musique%20Oblique%3B%20Philippe%20Herreweghe/Das%20Lied%20von%20der%20Erde%20(Version%20Schoenberg-Riehn)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2FHerreweghe%2FMahler%20-%20Das%20Lied%20von%20der%20Erde%20(Herreweghe%201994%20HM)%2F05%20-%20Das%20Lied%20von%20der%20Erde%20-%20Der%20Trunkene%20im%20Fr%C3%BChling.%20Allegro.flac&metadata=false Apr 06 12:48:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/05 - Das Lied von der Erde - Der Trunkene im Frühling. Allegro.flac Apr 06 12:48:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=Birgit%20Remmert%3B%20Hans%20Peter%20Blochwitz%3B%20Ensemble%20Musique%20Oblique%3B%20Philippe%20Herreweghe/Das%20Lied%20von%20der%20Erde%20(Version%20Schoenberg-Riehn)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FMahler%2FHerreweghe%2FMahler%20-%20Das%20Lied%20von%20der%20Erde%20(Herreweghe%201994%20HM)%2F06%20-%20Das%20Lied%20von%20der%20Erde%20-%20Der%20Abschied.%20Schwer.flac&metadata=false Apr 06 12:48:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/06 - Das Lied von der Erde - Der Abschied. Schwer.flac Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand stop took 46 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushQueue Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::saveQueue Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::updateTrackBlock Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrackBlock Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPlay Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::play index 0 Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::stop Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::play index undefined Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::startPlaybackTimer Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::clearAddPlayTracks USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand stop Apr 06 12:48:24 rivo volumio[5597]: info: Apr 06 12:48:24 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:24 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:24 rivo volumio[5597]: info: Apr 06 12:48:24 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:24 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand status took 24 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand stop took 13 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand status took 12 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand status took 11 milliseconds Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand clear Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:24 rivo volumio[5597]: error: Upnp client error: Error: This socket has been ended by the other party Apr 06 12:48:24 rivo volumio[5597]: info: Apr 06 12:48:24 rivo volumio[5597]: ---------------------------- MPD announces system playlist update Apr 06 12:48:24 rivo volumio[5597]: info: Ignoring MPD Status Update Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand clear took 13 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 06 12:48:24 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand add "USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac" Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:24 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:24 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:24 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:24 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:24 rivo volumio[5597]: 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":"Serenade Melancolique, op. 26","artist":"Itzhak Perlman, The Philadelphia Orchestra, Eugene Ormand","album":"Tchaikovsky Violin Concerto in D Major, op. 35, Serenade Meleacolique, Op.26","uri":"USB/LaCie_2/Tchaikovsky/Oeuvres concertantes/Concerto violon & orchestre op35/Tchaikovsky · Op.35 & Op.26 (Perlman, Ormandy EMI)/03 Serenade Melancolique, op. 26.flac","trackType":"flac"} Apr 06 12:48:24 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::syncState stateService stop Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus stop Apr 06 12:48:24 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: No code Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 88ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 66ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 65ms Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces system playlist update Apr 06 12:48:25 rivo volumio[5597]: info: Ignoring MPD Status Update Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces system playlist update Apr 06 12:48:25 rivo volumio[5597]: info: Ignoring MPD Status Update Apr 06 12:48:25 rivo volumio[5597]: error: updateQueue error: null Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces system playlist update Apr 06 12:48:25 rivo volumio[5597]: info: Ignoring MPD Status Update Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 66ms Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand add "USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac" took 58 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 20ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 19ms Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand play Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces system playlist update Apr 06 12:48:25 rivo volumio[5597]: info: Ignoring MPD Status Update Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces system playlist update Apr 06 12:48:25 rivo volumio[5597]: info: Ignoring MPD Status Update Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 14ms Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand play took 9 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 8ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 7ms Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand status took 19 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand status took 17 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand status took 15 milliseconds Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:25 rivo volumio[5597]: info: Apr 06 12:48:25 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand status took 16 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand status took 11 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand status took 9 milliseconds Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:25 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState stateService play Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus stop Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:25 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState stateService play Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus play Apr 06 12:48:25 rivo volumio[5597]: info: Received an update from plugin. extracting info from payload Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:25 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState stateService play Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus play Apr 06 12:48:25 rivo volumio[5597]: info: Received an update from plugin. extracting info from payload Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 90ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 95ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 93ms Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 77 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 71 milliseconds Apr 06 12:48:25 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 70 milliseconds Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:25 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:25 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState stateService play Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus play Apr 06 12:48:25 rivo volumio[5597]: info: Received an update from plugin. extracting info from payload Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:25 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState stateService play Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus play Apr 06 12:48:25 rivo volumio[5597]: info: Received an update from plugin. extracting info from payload Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:25 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState stateService play Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus play Apr 06 12:48:25 rivo volumio[5597]: info: Received an update from plugin. extracting info from payload Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:25 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:25 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:25 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 166ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 159ms Apr 06 12:48:25 rivo volumio[5597]: info: ------------------------------ 159ms Apr 06 12:48:25 rivo volumio[5597]: info: Signalling Playback active due to playback status change Apr 06 12:48:25 rivo volumio[5597]: error: Serial API: Failed to decode command: ��PUSH, message: PLAYBACK Apr 06 12:48:27 rivo volumio[5597]: info: Executing endpoint metavolumio Apr 06 12:48:27 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 06 12:48:27 rivo volumio[5597]: info: Executing endpoint metavolumio Apr 06 12:48:27 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 06 12:48:27 rivo volumio[5597]: info: Executing endpoint metavolumio Apr 06 12:48:27 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 06 12:48:31 rivo volumio[5597]: error: Failed request for metavolumio API Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::volumioPause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::stPlaybackTimer Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::servicePause Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::servicePause Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::pause Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand pause Apr 06 12:48:37 rivo volumio[5597]: info: Apr 06 12:48:37 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand pause took 6 milliseconds Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:37 rivo volumio[5597]: info: Apr 06 12:48:37 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:37 rivo volumio[5597]: info: Apr 06 12:48:37 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::getState Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand status Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand status took 9 milliseconds Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand status took 10 milliseconds Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand status took 8 milliseconds Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::parseState Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 06 12:48:37 rivo volumio[5597]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:37 rivo volumio[5597]: verbose: ControllerMpd::parseTrackInfo Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13705,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"645 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:37 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::syncState stateService pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:37 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:37 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::stPlaybackTimer Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13705,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"645 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:37 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::syncState stateService pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:37 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:37 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::stPlaybackTimer Apr 06 12:48:37 rivo volumio[5597]: info: ControllerMpd::pushState Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::servicePushState Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13705,"duration":493,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"645 Kbps","isStreaming":false,"title":"Das Lied von der Erde: Das Trinklied vom Jammer der Erde. Allegro pesante","artist":"Birgit Remmert; Hans Peter Blochwitz; Ensemble Musique Oblique; Philippe Herreweghe","album":"Das Lied von der Erde (Version Schoenberg-Riehn)","uri":"USB/LaCie_2/Mahler/Herreweghe/Mahler - Das Lied von der Erde (Herreweghe 1994 HM)/01 - Das Lied von der Erde - Das Trinklied vom Jammer der Erde. Allegro pesante.flac","trackType":"flac"} Apr 06 12:48:37 rivo volumio[5597]: verbose: CURRENT POSITION 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::syncState stateService pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::syncState currentStatus pause Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:48:37 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:48:37 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:48:37 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:48:37 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:48:37 rivo volumio[5597]: info: CoreStateMachine::stPlaybackTimer Apr 06 12:48:37 rivo volumio[5597]: info: ------------------------------ 75ms Apr 06 12:48:37 rivo volumio[5597]: info: ------------------------------ 70ms Apr 06 12:48:37 rivo volumio[5597]: info: ------------------------------ 68ms Apr 06 12:48:37 rivo volumio[5597]: info: MCU Signalled Playback Inactive Apr 06 12:48:49 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 06 12:48:49 rivo volumio[5597]: info: CURURI: music-library/USB/LaCie_2/Korsakov Apr 06 12:48:49 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:49:15 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 06 12:49:15 rivo volumio[5597]: info: CURURI: music-library/USB/LaCie_2/Handel Apr 06 12:49:15 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:49:20 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 06 12:49:20 rivo volumio[5597]: info: CURURI: music-library/USB/LaCie_2/Handel/1995 - Handel - Messiah (David Willcocks, NightPro Symphony Orchestra) Apr 06 12:49:20 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:49:24 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:49:24 rivo volumio[5597]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::ClearQueue Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::stop Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::updateTrackBlock Apr 06 12:49:24 rivo volumio[5597]: info: CorePlayQueue::getTrackBlock Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::stPlaybackTimer Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::pushState Apr 06 12:49:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:49:24 rivo volumio[5597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:49:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushState Apr 06 12:49:24 rivo volumio[5597]: info: MRS: Pushing multiroomSync output update for this device Apr 06 12:49:24 rivo volumio[5597]: info: MRS: Pushing multiroomSync output Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::serviceStop Apr 06 12:49:24 rivo volumio[5597]: info: CorePlayQueue::getTrack 0 Apr 06 12:49:24 rivo volumio[5597]: info: CoreCommandRouter::serviceStop Apr 06 12:49:24 rivo volumio[5597]: info: ControllerMpd::stop Apr 06 12:49:24 rivo volumio[5597]: verbose: ControllerMpd::sendMpdCommand stop Apr 06 12:49:24 rivo volumio[5597]: info: CorePlayQueue::clearPlayQueue Apr 06 12:49:24 rivo volumio[5597]: info: CorePlayQueue::saveQueue Apr 06 12:49:24 rivo volumio[5597]: info: CoreCommandRouter::volumioPushQueue Apr 06 12:49:24 rivo volumio[5597]: info: CoreStateMachine::addQueueItems Apr 06 12:49:24 rivo volumio[5597]: info: CorePlayQueue::addQueueItems Apr 06 12:49:24 rivo volumio[5597]: info: Preload queue cleared Apr 06 12:49:24 rivo volumio[5597]: info: Adding Item to queue: music-library/USB/LaCie_2/Handel/1995 - Handel - Messiah (David Willcocks, NightPro Symphony Orchestra) Apr 06 12:49:24 rivo volumio[5597]: info: Exploding uri music-library/USB/LaCie_2/Handel/1995 - Handel - Messiah (David Willcocks, NightPro Symphony Orchestra) in service mpd Apr 06 12:49:24 rivo volumio[5597]: info: Apr 06 12:49:24 rivo volumio[5597]: ---------------------------- MPD announces state update: player Apr 06 12:49:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=David%20Willcocks/Handel%20-%20Messiah%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FHandel%2F1995%20-%20Handel%20-%20Messiah%20(David%20Willcocks%2C%20NightPro%20Symphony%20Orchestra)%2FCD1%2FHandel%20-%20Messiah%20(Disc%201)%20-%20David%20Willcocks%2C%20NightPro%20Symphony%20Orchestra.flac&metadata=false Apr 06 12:49:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Handel/1995 - Handel - Messiah (David Willcocks, NightPro Symphony Orchestra)/CD1/Handel - Messiah (Disc 1) - David Willcocks, NightPro Symphony Orchestra.flac Apr 06 12:49:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=NightPro%20Symphony%20Orchestra%2C%20Sir%20David%20Willcocks/Handel%20-%20Messiah%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FHandel%2F1995%20-%20Handel%20-%20Messiah%20(David%20Willcocks%2C%20NightPro%20Symphony%20Orchestra)%2FCD1%2FHandel%20-%20Messiah%20(Disc%202)%20-%20David%20Willcocks%2C%20NightPro%20Symphony%20Orchestra.cue&metadata=false Apr 06 12:49:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Handel/1995 - Handel - Messiah (David Willcocks, NightPro Symphony Orchestra)/CD1/Handel - Messiah (Disc 2) - David Willcocks, NightPro Symphony Orchestra.cue Apr 06 12:49:24 rivo volumio[5597]: info: ALBUMART /albumart?cacheid=116&web=NightPro%20Symphony%20Orchestra%2C%20Sir%20David%20Willcocks%20%26%20Neil%20Mackie/Handel%20-%20Messiah%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FLaCie_2%2FHandel%2F1995%20-%20Handel%20-%20Messiah%20(David%20Willcocks%2C%20NightPro%20Symphony%20Orchestra)%2FCD1%2FHandel%20-%20Messiah%20(Disc%202)%20-%20David%20Willcocks%2C%20NightPro%20Symphony%20Orchestra.cue&metadata=false Apr 06 12:49:24 rivo volumio[5597]: info: URI /mnt/USB/LaCie_2/Handel/1995 - Handel - Messiah (David Willcocks, NightPro Symphony Orchestra)/CD1/Handel - Messiah (Disc 2) - David Willcocks, NightPro Symphony Orchestra.cue Apr 06 12:49:24 rivo volumio[5597]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 12:49:24 rivo volumio[5597]: Error: Unable to resolve or reject the same promise twice Apr 06 12:49:24 rivo volumio[5597]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 06 12:49:24 rivo volumio[5597]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 06 12:49:24 rivo volumio[5597]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 06 12:49:24 rivo volumio[5597]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 06 12:49:24 rivo volumio[5597]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 06 12:49:24 rivo volumio[5597]: at Socket.emit (events.js:400:28) Apr 06 12:49:24 rivo volumio[5597]: at addChunk (internal/streams/readable.js:293:12) Apr 06 12:49:24 rivo volumio[5597]: at readableAddChunk (internal/streams/readable.js:263:11) Apr 06 12:49:24 rivo volumio[5597]: at Socket.Readable.push (internal/streams/readable.js:206:10) Apr 06 12:49:24 rivo volumio[5597]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 06 12:49:24 rivo volumio[5597]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 12:49:25 rivo sudo[9797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 12:48 Apr 06 12:49:25 rivo sudo[9797]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:41:55 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b0437c7088d6645a661a49f6d9fa596a"