-- Logs begin at Wed 2024-10-02 13:18:38 CST, end at Wed 2024-10-02 13:36:48 CST. -- Oct 02 13:35:00 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:35:00 volumio volumio[968]: info: CURURI: music-library/USB/HIKSEMI Oct 02 13:35:00 volumio volumio[968]: info: Preload queue cleared Oct 02 13:35:01 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:35:01 volumio volumio[968]: info: CURURI: music-library/USB/HIKSEMI/Music Oct 02 13:35:01 volumio volumio[968]: info: Preload queue cleared Oct 02 13:35:03 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:35:03 volumio volumio[968]: info: CURURI: music-library Oct 02 13:35:03 volumio volumio[968]: info: Preload queue cleared Oct 02 13:35:24 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:35:24 volumio volumio[968]: info: CURURI: music-library Oct 02 13:35:24 volumio volumio[968]: info: Preload queue cleared Oct 02 13:35:34 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:35:34 volumio volumio[968]: info: Preload queue cleared Oct 02 13:35:45 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:35:45 volumio volumio[968]: info: CURURI: music-library Oct 02 13:35:45 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:02 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:36:02 volumio volumio[968]: info: CURURI: music-library/USB Oct 02 13:36:02 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:04 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:36:04 volumio volumio[968]: info: CURURI: music-library/USB/HIKSEMI Oct 02 13:36:04 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:05 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:36:05 volumio volumio[968]: info: CURURI: music-library/USB/HIKSEMI/Music Oct 02 13:36:05 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:06 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:36:06 volumio volumio[968]: info: CURURI: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG Oct 02 13:36:06 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:08 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:36:08 volumio volumio[968]: info: CURURI: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1 Oct 02 13:36:08 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/01.Sonata No. 1 in G Minor - Adagio.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/02.Sonata No. 1 in G Minor - Fuga Allegro.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/03.Sonata No. 1 in G Minor - Siciliana.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/04.Sonata No. 1 in G Minor - Presto.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/05.Partita No. 1 in B Minor - Allemanda.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/06.Partita No. 1 in B Minor - Double 1.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/07.Partita No. 1 in B Minor - Corrente.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/08.Partita No. 1 in B Minor - Double Presto.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/09.Partita No. 1 in B Minor - Sarabande.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/10.Partita No. 1 in B Minor - Double 2.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/11.Partita No. 1 in B Minor - Tempo di Borea.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/12.Partita No. 1 in B Minor - Double 3.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/13.Sonata No. 2 in A Minor - Grave.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/14.Sonata No. 2 in A Minor - Fuga.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/15.Sonata No. 2 in A Minor - Andante.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Preloading song: music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/16.Sonata No. 2 in A Minor - Allegro.mp3 Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/01.Sonata No. 1 in G Minor - Adagio.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/01.Sonata No. 1 in G Minor - Adagio.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/02.Sonata No. 1 in G Minor - Fuga Allegro.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/02.Sonata No. 1 in G Minor - Fuga Allegro.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/03.Sonata No. 1 in G Minor - Siciliana.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/03.Sonata No. 1 in G Minor - Siciliana.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/04.Sonata No. 1 in G Minor - Presto.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/04.Sonata No. 1 in G Minor - Presto.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/05.Partita No. 1 in B Minor - Allemanda.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/05.Partita No. 1 in B Minor - Allemanda.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/06.Partita No. 1 in B Minor - Double 1.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/06.Partita No. 1 in B Minor - Double 1.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/07.Partita No. 1 in B Minor - Corrente.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/07.Partita No. 1 in B Minor - Corrente.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/08.Partita No. 1 in B Minor - Double Presto.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/08.Partita No. 1 in B Minor - Double Presto.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/09.Partita No. 1 in B Minor - Sarabande.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/09.Partita No. 1 in B Minor - Sarabande.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/10.Partita No. 1 in B Minor - Double 2.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/10.Partita No. 1 in B Minor - Double 2.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/11.Partita No. 1 in B Minor - Tempo di Borea.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/11.Partita No. 1 in B Minor - Tempo di Borea.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/12.Partita No. 1 in B Minor - Double 3.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/12.Partita No. 1 in B Minor - Double 3.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/13.Sonata No. 2 in A Minor - Grave.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/13.Sonata No. 2 in A Minor - Grave.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/14.Sonata No. 2 in A Minor - Fuga.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/14.Sonata No. 2 in A Minor - Fuga.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/15.Sonata No. 2 in A Minor - Andante.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/15.Sonata No. 2 in A Minor - Andante.mp3' Oct 02 13:36:08 volumio volumio[968]: info: Exploding uri music-library/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/16.Sonata No. 2 in A Minor - Allegro.mp3 in service mpd Oct 02 13:36:08 volumio volumio[968]: error: scanFolder - failure to stat '/mnt/USB/HIKSEMI/Music/BACH Sonatas And Partitas For Solo Violin BWV 1001-1006 Milstein DG/CD1/16.Sonata No. 2 in A Minor - Allegro.mp3' Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:36:17 volumio volumio[968]: info: Retrieving Cloud Streaming UI Oct 02 13:36:17 volumio volumio[968]: info: Getting Tidal Cloud Configuration Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:36:17 volumio volumio[968]: info: Getting Qobuz Cloud Configuration Oct 02 13:36:17 volumio volumio[968]: info: Asking plugin for UI Config Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:36:17 volumio volumio[968]: info: Getting Spotify Cloud Configuration Oct 02 13:36:17 volumio volumio[968]: info: Asking plugin for UI Config Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:36:17 volumio volumio[968]: info: Saving Spotify Acccount Oct 02 13:36:17 volumio volumio[968]: info: Got Tidal Cloud Configuration Oct 02 13:36:17 volumio volumio[968]: info: Got it Oct 02 13:36:17 volumio volumio[968]: info: Got it Oct 02 13:36:17 volumio volumio[968]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 02 13:36:17 volumio volumio[968]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::volumioGetBrowseSources Oct 02 13:36:17 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:36:18 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 02 13:36:22 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand update Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand update took 1 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 2 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 1 milliseconds Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: Command Router : Notfying DB Updatetrue Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: Command Router : Notfying DB Updatetrue Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: Command Router : Notfying DB Updatetrue Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ------------------------------ 141ms Oct 02 13:36:24 volumio volumio[968]: info: ------------------------------ 140ms Oct 02 13:36:24 volumio volumio[968]: info: MPD Database updated - AlbumList cache refreshed Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: database Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: MPD Database updated - AlbumList cache refreshed Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: database Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: MPD Database updated - AlbumList cache refreshed Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: database Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: Oct 02 13:36:24 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 11 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 11 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 10 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 10 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 9 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 9 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 8 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 8 milliseconds Oct 02 13:36:24 volumio volumio[968]: info: sendMpdCommand status took 9 milliseconds Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:24 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: No code Oct 02 13:36:24 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:24 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:24 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:24 volumio volumio[968]: info: ------------------------------ 119ms Oct 02 13:36:24 volumio volumio[968]: info: ------------------------------ 120ms Oct 02 13:36:24 volumio volumio[968]: info: ------------------------------ 119ms Oct 02 13:36:24 volumio volumio[968]: info: ------------------------------ 118ms Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand update Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: Oct 02 13:36:25 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand update took 3 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: Oct 02 13:36:25 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: Oct 02 13:36:25 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: Oct 02 13:36:25 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 8 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 6 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 6 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 5 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 5 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 4 milliseconds Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:25 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: No code Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:25 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: No code Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:25 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: No code Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: ------------------------------ 114ms Oct 02 13:36:25 volumio volumio[968]: info: ------------------------------ 112ms Oct 02 13:36:25 volumio volumio[968]: info: ------------------------------ 111ms Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: Oct 02 13:36:25 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: Oct 02 13:36:25 volumio volumio[968]: ---------------------------- MPD announces state update: update Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::getState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 111 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 109 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 2 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 2 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 2 milliseconds Oct 02 13:36:25 volumio volumio[968]: info: sendMpdCommand status took 2 milliseconds Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: Command Router : Notfying DB Updatefalse Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::Close All Modals sent Oct 02 13:36:25 volumio volumio[968]: verbose: ControllerMpd::parseState Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:25 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: No code Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:25 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: No code Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: ControllerMpd::pushState Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::servicePushState Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 02 13:36:25 volumio volumio[968]: verbose: CURRENT POSITION 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: No code Oct 02 13:36:25 volumio volumio[968]: info: CoreStateMachine::pushState Oct 02 13:36:25 volumio volumio[968]: info: CorePlayQueue::getTrack 0 Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Oct 02 13:36:25 volumio volumio[968]: info: ------------------------------ 197ms Oct 02 13:36:25 volumio volumio[968]: info: ------------------------------ 88ms Oct 02 13:36:25 volumio volumio[968]: info: ------------------------------ 88ms Oct 02 13:36:25 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:36:29 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:36:33 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:36:37 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 13:36:44 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:36:44 volumio volumio[968]: info: CURURI: music-library Oct 02 13:36:44 volumio volumio[968]: info: Preload queue cleared Oct 02 13:36:48 volumio volumio[968]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:36:48 volumio volumio[968]: Error: connect ETIMEDOUT 199.16.158.182:80 Oct 02 13:36:48 volumio volumio[968]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 02 13:36:48 volumio volumio[968]: errno: -110, Oct 02 13:36:48 volumio volumio[968]: code: 'ETIMEDOUT', Oct 02 13:36:48 volumio volumio[968]: syscall: 'connect', Oct 02 13:36:48 volumio volumio[968]: address: '199.16.158.182', Oct 02 13:36:48 volumio volumio[968]: port: 80 Oct 02 13:36:48 volumio volumio[968]: } Oct 02 13:36:48 volumio volumio[968]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:36:48 volumio sudo[3116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-02 13:35 Oct 02 13:36:48 volumio sudo[3116]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"