-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-10-12 18:53:04 CEST. -- Oct 12 18:52:23 volumio ntpd[776]: receive: Unexpected origin timestamp 0xeab526c9.4f1b9141 does not match aorg 0000000000.00000000 from server@217.61.62.224 xmt 0xeab527c7.5c2bdc58 Oct 12 18:52:23 volumio ntpd[776]: receive: Unexpected origin timestamp 0xeab526c9.4f1a8b15 does not match aorg 0000000000.00000000 from server@93.44.243.48 xmt 0xeab527c7.5d5c35e8 Oct 12 18:52:23 volumio ntpd[776]: receive: Unexpected origin timestamp 0xeab526c9.4f1783b9 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xeab527c7.5d946eaa Oct 12 18:52:23 volumio ntpd[776]: receive: Unexpected origin timestamp 0xeab526c9.4f19ae48 does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xeab527c7.5f26c760 Oct 12 18:52:23 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 18:52:23 volumio volumio[976]: info: CURURI: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA Oct 12 18:52:24 volumio volumio[976]: info: Preload queue cleared Oct 12 18:52:24 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 18:52:24 volumio volumio[976]: info: CURURI: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI Oct 12 18:52:25 volumio volumio[976]: info: Preload queue cleared Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/02 Il tempo che verrà (new version).mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/03 La notte.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/04 L'amore è un'altra cosa.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/06 Democrazia.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/07 Bene se ti sta bene.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/08 Poi però.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/09 Si vola.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/10 Nel regno di chissà che c'è.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Preloading song: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/11 Missiva d'amore.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F01%20Amami.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/02 Il tempo che verrà (new version).mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F02%20Il%20tempo%20che%20verr%C3%A0%20(new%20version).mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/02 Il tempo che verrà (new version).mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/03 La notte.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F03%20La%20notte.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/03 La notte.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/04 L'amore è un'altra cosa.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F04%20L'amore%20%C3%A8%20un'altra%20cosa.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/04 L'amore è un'altra cosa.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F05%20Ci%20sei%20e%20se%20non%20ci%20sei.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/06 Democrazia.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F06%20Democrazia.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/06 Democrazia.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/07 Bene se ti sta bene.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F07%20Bene%20se%20ti%20sta%20bene.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/07 Bene se ti sta bene.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/08 Poi però.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F08%20Poi%20per%C3%B2.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/08 Poi però.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/09 Si vola.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F09%20Si%20vola.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/09 Si vola.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/10 Nel regno di chissà che c'è.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F10%20Nel%20regno%20di%20chiss%C3%A0%20che%20c'%C3%A8.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/10 Nel regno di chissà che c'è.mp3 Oct 12 18:52:25 volumio volumio[976]: info: Exploding uri music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/11 Missiva d'amore.mp3 in service mpd Oct 12 18:52:25 volumio volumio[976]: info: ALBUMART /albumart?cacheid=720&web=Arisa/Amami/extralarge&path=%2Fmnt%2FNAS%2FDocumenti_e_Files%2FMP3%2FITALIANA%2FARISA%2FAMAMI%2F11%20Missiva%20d'amore.mp3&metadata=false Oct 12 18:52:25 volumio volumio[976]: info: URI /mnt/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/11 Missiva d'amore.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Preload queue cleared Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::ClearQueue Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::stop Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::clearPlayQueue Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::saveQueue Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::addQueueItems Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::addQueueItems Oct 12 18:52:26 volumio volumio[976]: info: Preload queue cleared Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/02 Il tempo che verrà (new version).mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/02 Il tempo che verrà (new version).mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/03 La notte.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/03 La notte.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/04 L'amore è un'altra cosa.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/04 L'amore è un'altra cosa.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/06 Democrazia.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/06 Democrazia.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/07 Bene se ti sta bene.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/07 Bene se ti sta bene.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/08 Poi però.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/08 Poi però.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/09 Si vola.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/09 Si vola.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/10 Nel regno di chissà che c'è.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/10 Nel regno di chissà che c'è.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Adding Item to queue: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/11 Missiva d'amore.mp3 Oct 12 18:52:26 volumio volumio[976]: info: Using cached record of: music-library/NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/11 Missiva d'amore.mp3 Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::saveQueue Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::volumioPlay Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::play index 0 Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::stop Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::play index undefined Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::startPlaybackTimer Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::clearAddPlayTracks NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3 Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand stop took 5 milliseconds Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 18:52:26 volumio volumio[976]: info: Oct 12 18:52:26 volumio volumio[976]: ---------------------------- MPD announces system playlist update Oct 12 18:52:26 volumio volumio[976]: info: Ignoring MPD Status Update Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand clear took 2 milliseconds Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand add "NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3" Oct 12 18:52:26 volumio volumio[976]: error: updateQueue error: null Oct 12 18:52:26 volumio volumio[976]: info: Oct 12 18:52:26 volumio volumio[976]: ---------------------------- MPD announces system playlist update Oct 12 18:52:26 volumio volumio[976]: info: Ignoring MPD Status Update Oct 12 18:52:26 volumio volumio[976]: info: ------------------------------ 3ms Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand add "NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3" took 2 milliseconds Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand play Oct 12 18:52:26 volumio volumio[976]: info: ------------------------------ 3ms Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand play took 2 milliseconds Oct 12 18:52:26 volumio volumio[976]: info: Oct 12 18:52:26 volumio volumio[976]: ---------------------------- MPD announces state update: player Oct 12 18:52:26 volumio volumio[976]: info: ControllerMpd::getState Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:52:26 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 12 18:52:26 volumio volumio[976]: info: Oct 12 18:52:26 volumio volumio[976]: ---------------------------- MPD announces state update: player Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand status took 38 milliseconds Oct 12 18:52:26 volumio volumio[976]: info: ControllerMpd::getState Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::parseState Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand status took 2 milliseconds Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::parseState Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:52:26 volumio volumio[976]: info: ControllerMpd::pushState Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:26 volumio volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Amami","artist":"Arisa","album":"Amami","uri":"NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3","trackType":"mp3"} Oct 12 18:52:26 volumio volumio[976]: verbose: CURRENT POSITION 0 Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::syncState stateService play Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:52:26 volumio volumio[976]: info: ------------------------------ 47ms Oct 12 18:52:26 volumio volumio[976]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 12 18:52:26 volumio volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:52:26 volumio volumio[976]: info: ControllerMpd::pushState Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:26 volumio volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Amami","artist":"Arisa","album":"Amami","uri":"NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3","trackType":"mp3"} Oct 12 18:52:26 volumio volumio[976]: verbose: CURRENT POSITION 0 Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::syncState stateService play Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 12 18:52:26 volumio volumio[976]: info: Received an update from plugin. extracting info from payload Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:26 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:26 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:26 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:26 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:26 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:26 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:26 volumio volumio[976]: info: ------------------------------ 52ms Oct 12 18:52:26 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Oct 12 18:52:26 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Oct 12 18:52:34 volumio volumio[976]: info: VolumeController::SetAlsaVolume55 Oct 12 18:52:34 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:34 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:34 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:34 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:34 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:34 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:34 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55 Oct 12 18:52:34 volumio volumio[976]: SPOTIFY: SPOTIFY VOLUME 45 Oct 12 18:52:34 volumio volumio[976]: SPOTIFY: VOLUMIO VOLUME 55 Oct 12 18:52:34 volumio volumio[976]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 18:52:34 volumio volumio[976]: info: Setting Spotify Volume from Volumio: 55 Oct 12 18:52:34 volumio volumio[976]: info: VolumeController::SetAlsaVolume70 Oct 12 18:52:35 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:35 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:35 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:35 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:35 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:35 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:35 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:35 volumio volumio[976]: SPOTIFY: SPOTIFY VOLUME 55 Oct 12 18:52:35 volumio volumio[976]: SPOTIFY: VOLUMIO VOLUME 70 Oct 12 18:52:35 volumio volumio[976]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 18:52:35 volumio volumio[976]: info: Setting Spotify Volume from Volumio: 70 Oct 12 18:52:36 volumio volumio[976]: SPOTIFY: SETTING SPOTIFY VOLUME 70 Oct 12 18:52:36 volumio volumio[976]: info: Sending Spotify command with payload to local API: /player/volume Oct 12 18:52:41 volumio volumio[976]: info: VolumeController::SetAlsaVolumemute Oct 12 18:52:41 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:41 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:41 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:41 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:41 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:41 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:41 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 Oct 12 18:52:41 volumio volumio[976]: SPOTIFY: SPOTIFY VOLUME 70 Oct 12 18:52:41 volumio volumio[976]: SPOTIFY: VOLUMIO VOLUME 0 Oct 12 18:52:41 volumio volumio[976]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 18:52:41 volumio volumio[976]: info: Setting Spotify Volume from Volumio: 0 Oct 12 18:52:43 volumio volumio[976]: info: VolumeController::SetAlsaVolume+ Oct 12 18:52:43 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:43 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:43 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:43 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:43 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:43 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:43 volumio volumio[976]: SPOTIFY: SETTING SPOTIFY VOLUME 0 Oct 12 18:52:43 volumio volumio[976]: info: Sending Spotify command with payload to local API: /player/volume Oct 12 18:52:43 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Oct 12 18:52:43 volumio volumio[976]: SPOTIFY: SPOTIFY VOLUME 0 Oct 12 18:52:43 volumio volumio[976]: SPOTIFY: VOLUMIO VOLUME 71 Oct 12 18:52:43 volumio volumio[976]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 18:52:43 volumio volumio[976]: info: Setting Spotify Volume from Volumio: 71 Oct 12 18:52:43 volumio volumio[976]: info: VolumeController::SetAlsaVolumemute Oct 12 18:52:44 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:44 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:44 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:44 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:44 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:44 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: SPOTIFY VOLUME 71 Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: VOLUMIO VOLUME 0 Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 18:52:44 volumio volumio[976]: info: Setting Spotify Volume from Volumio: 0 Oct 12 18:52:44 volumio volumio[976]: info: VolumeController::SetAlsaVolume- Oct 12 18:52:44 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:44 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:44 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:44 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:44 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:44 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: SPOTIFY VOLUME 0 Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: VOLUMIO VOLUME 70 Oct 12 18:52:44 volumio volumio[976]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 18:52:44 volumio volumio[976]: info: Setting Spotify Volume from Volumio: 70 Oct 12 18:52:46 volumio volumio[976]: SPOTIFY: SETTING SPOTIFY VOLUME 70 Oct 12 18:52:46 volumio volumio[976]: info: Sending Spotify command with payload to local API: /player/volume Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::volumioPlay Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::play index 4 Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::stop Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::stPlaybackTimer Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::serviceStop Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::serviceStop Oct 12 18:52:49 volumio volumio[976]: info: ControllerMpd::stop Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:52:49 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:49 volumio volumio[976]: info: Oct 12 18:52:49 volumio volumio[976]: ---------------------------- MPD announces state update: player Oct 12 18:52:49 volumio volumio[976]: info: sendMpdCommand stop took 24 milliseconds Oct 12 18:52:49 volumio volumio[976]: info: ControllerMpd::getState Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::play index undefined Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::startPlaybackTimer Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::clearAddPlayTracks NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3 Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 18:52:49 volumio volumio[976]: info: sendMpdCommand status took 3 milliseconds Oct 12 18:52:49 volumio volumio[976]: info: sendMpdCommand stop took 1 milliseconds Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::parseState Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 18:52:49 volumio volumio[976]: info: Oct 12 18:52:49 volumio volumio[976]: ---------------------------- MPD announces system playlist update Oct 12 18:52:49 volumio volumio[976]: info: Ignoring MPD Status Update Oct 12 18:52:49 volumio volumio[976]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 12 18:52:49 volumio volumio[976]: info: sendMpdCommand clear took 33 milliseconds Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:52:49 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand add "NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3" Oct 12 18:52:49 volumio volumio[976]: info: ControllerMpd::pushState Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:49 volumio volumio[976]: 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":"Amami","artist":"Arisa","album":"Amami","uri":"NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/01 Amami.mp3","trackType":"mp3"} Oct 12 18:52:49 volumio volumio[976]: verbose: CURRENT POSITION 4 Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::syncState stateService stop Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:49 volumio volumio[976]: info: No code Oct 12 18:52:49 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:49 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:49 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:49 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:50 volumio volumio[976]: info: ------------------------------ 110ms Oct 12 18:52:50 volumio volumio[976]: error: updateQueue error: null Oct 12 18:52:50 volumio volumio[976]: info: Oct 12 18:52:50 volumio volumio[976]: ---------------------------- MPD announces system playlist update Oct 12 18:52:50 volumio volumio[976]: info: Ignoring MPD Status Update Oct 12 18:52:50 volumio volumio[976]: info: ------------------------------ 78ms Oct 12 18:52:50 volumio volumio[976]: info: sendMpdCommand add "NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3" took 75 milliseconds Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand play Oct 12 18:52:50 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:50 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:50 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:50 volumio volumio[976]: info: touch_display: Setting screensaver timeout to 1200 seconds. Oct 12 18:52:50 volumio volumio[976]: info: ------------------------------ 31ms Oct 12 18:52:50 volumio volumio[976]: info: sendMpdCommand play took 28 milliseconds Oct 12 18:52:50 volumio volumio[976]: info: Oct 12 18:52:50 volumio volumio[976]: ---------------------------- MPD announces state update: player Oct 12 18:52:50 volumio volumio[976]: info: ControllerMpd::getState Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:52:50 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 12 18:52:50 volumio volumio[976]: info: Oct 12 18:52:50 volumio volumio[976]: ---------------------------- MPD announces state update: player Oct 12 18:52:50 volumio volumio[976]: info: sendMpdCommand status took 26 milliseconds Oct 12 18:52:50 volumio volumio[976]: info: ControllerMpd::getState Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand status Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::parseState Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:52:50 volumio volumio[976]: info: sendMpdCommand status took 2 milliseconds Oct 12 18:52:50 volumio volumio[976]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::parseState Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:52:50 volumio volumio[976]: info: ControllerMpd::pushState Oct 12 18:52:50 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 12 18:52:50 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:50 volumio volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Ci sei e se non ci sei","artist":"Arisa","album":"Amami","uri":"NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3","trackType":"mp3"} Oct 12 18:52:50 volumio volumio[976]: verbose: CURRENT POSITION 4 Oct 12 18:52:50 volumio volumio[976]: info: CoreStateMachine::syncState stateService play Oct 12 18:52:50 volumio volumio[976]: info: CoreStateMachine::syncState currentStatus stop Oct 12 18:52:50 volumio volumio[976]: info: ------------------------------ 33ms Oct 12 18:52:50 volumio volumio[976]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 12 18:52:50 volumio volumio[976]: verbose: ControllerMpd::parseTrackInfo Oct 12 18:52:50 volumio volumio[976]: info: ControllerMpd::pushState Oct 12 18:52:50 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 12 18:52:50 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:50 volumio volumio[976]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Ci sei e se non ci sei","artist":"Arisa","album":"Amami","uri":"NAS/Documenti_e_Files/MP3/ITALIANA/ARISA/AMAMI/05 Ci sei e se non ci sei.mp3","trackType":"mp3"} Oct 12 18:52:50 volumio volumio[976]: verbose: CURRENT POSITION 4 Oct 12 18:52:50 volumio volumio[976]: info: CoreStateMachine::syncState stateService play Oct 12 18:52:50 volumio volumio[976]: info: CoreStateMachine::syncState currentStatus play Oct 12 18:52:50 volumio volumio[976]: info: Received an update from plugin. extracting info from payload Oct 12 18:52:50 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:50 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:50 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 18:52:50 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:50 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:50 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:50 volumio volumio[976]: info: CoreStateMachine::pushState Oct 12 18:52:50 volumio volumio[976]: info: CorePlayQueue::getTrack 4 Oct 12 18:52:50 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 12 18:52:50 volumio volumio[976]: info: MRS: Pushing multiroomSync output update for this device Oct 12 18:52:50 volumio volumio[976]: info: MRS: Pushing multiroomSync output Oct 12 18:52:50 volumio volumio[976]: info: ------------------------------ 57ms Oct 12 18:52:50 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:50 volumio volumio[976]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:55 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:52:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Oct 12 18:52:56 volumio volumio[976]: error: MRS: impossible to set browserPlayback volume: device not found Oct 12 18:53:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Oct 12 18:53:04 volumio volumio[976]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Oct 12 18:53:04 volumio volumio[976]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 18:53:04 volumio volumio[976]: TypeError: Cannot read property 'then' of undefined Oct 12 18:53:04 volumio volumio[976]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Oct 12 18:53:04 volumio volumio[976]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2260:30) Oct 12 18:53:04 volumio volumio[976]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1442:26) Oct 12 18:53:04 volumio volumio[976]: at Socket.emit (events.js:315:20) Oct 12 18:53:04 volumio volumio[976]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 12 18:53:04 volumio volumio[976]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 12 18:53:04 volumio volumio[976]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 18:53:04 volumio sudo[1958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 18:52 Oct 12 18:53:04 volumio sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"