-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-11-02 16:00:15 CET. -- Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:59:02 volumio volumio[855]: info: Retrieving Cloud Streaming UI Nov 02 15:59:02 volumio volumio[855]: info: Getting Tidal Cloud Configuration Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:59:02 volumio volumio[855]: info: Getting Qobuz Cloud Configuration Nov 02 15:59:02 volumio volumio[855]: info: Asking plugin for UI Config Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:59:02 volumio volumio[855]: info: Getting Spotify Cloud Configuration Nov 02 15:59:02 volumio volumio[855]: info: Asking plugin for UI Config Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:59:02 volumio volumio[855]: info: Saving Spotify Acccount Nov 02 15:59:02 volumio volumio[855]: info: Got Tidal Cloud Configuration Nov 02 15:59:02 volumio volumio[855]: info: Got it Nov 02 15:59:02 volumio volumio[855]: info: Got it Nov 02 15:59:02 volumio volumio[855]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:59:02 volumio volumio[855]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 02 15:59:06 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand update Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: Nov 02 15:59:07 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand update took 9 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: Nov 02 15:59:07 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: Nov 02 15:59:07 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 18 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 12 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 7 milliseconds Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: Command Router : Notfying DB Updatetrue Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: Command Router : Notfying DB Updatetrue Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: Command Router : Notfying DB Updatetrue Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: 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} Nov 02 15:59:07 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: No code Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: 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} Nov 02 15:59:07 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: No code Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: 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} Nov 02 15:59:07 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: No code Nov 02 15:59:07 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:07 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:07 volumio volumio[855]: info: ------------------------------ 411ms Nov 02 15:59:07 volumio volumio[855]: info: ------------------------------ 405ms Nov 02 15:59:07 volumio volumio[855]: info: ------------------------------ 403ms Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: Nov 02 15:59:07 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: Nov 02 15:59:07 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: Nov 02 15:59:07 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:07 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 53 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 51 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 51 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 48 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 47 milliseconds Nov 02 15:59:07 volumio volumio[855]: info: sendMpdCommand status took 45 milliseconds Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:07 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:07 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:07 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: 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} Nov 02 15:59:08 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: No code Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: 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} Nov 02 15:59:08 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: No code Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: 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} Nov 02 15:59:08 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: No code Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: ------------------------------ 474ms Nov 02 15:59:08 volumio volumio[855]: info: ------------------------------ 472ms Nov 02 15:59:08 volumio volumio[855]: info: ------------------------------ 471ms Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand rescan Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand rescan took 1 milliseconds Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: info: Nov 02 15:59:08 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: info: Nov 02 15:59:08 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: info: Nov 02 15:59:08 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: info: Nov 02 15:59:08 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:59:08 volumio volumio[855]: info: sendMpdCommand status took 7 milliseconds Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:08 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:08 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:08 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:08 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: 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} Nov 02 15:59:08 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: No code Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: 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} Nov 02 15:59:08 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: No code Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: 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} Nov 02 15:59:08 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:08 volumio volumio[855]: info: No code Nov 02 15:59:08 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:08 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: ------------------------------ 236ms Nov 02 15:59:09 volumio volumio[855]: info: ------------------------------ 236ms Nov 02 15:59:09 volumio volumio[855]: info: ------------------------------ 234ms Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:09 volumio volumio[855]: info: Nov 02 15:59:09 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:09 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:09 volumio volumio[855]: info: Nov 02 15:59:09 volumio volumio[855]: ---------------------------- MPD announces state update: update Nov 02 15:59:09 volumio volumio[855]: info: ControllerMpd::getState Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:59:09 volumio volumio[855]: info: sendMpdCommand status took 265 milliseconds Nov 02 15:59:09 volumio volumio[855]: info: sendMpdCommand status took 263 milliseconds Nov 02 15:59:09 volumio volumio[855]: info: sendMpdCommand status took 33 milliseconds Nov 02 15:59:09 volumio volumio[855]: info: sendMpdCommand status took 32 milliseconds Nov 02 15:59:09 volumio volumio[855]: info: sendMpdCommand status took 31 milliseconds Nov 02 15:59:09 volumio volumio[855]: info: sendMpdCommand status took 30 milliseconds Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:09 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:09 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:09 volumio volumio[855]: info: Command Router : Notfying DB Updatefalse Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent Nov 02 15:59:09 volumio volumio[855]: verbose: ControllerMpd::parseState Nov 02 15:59:09 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: 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} Nov 02 15:59:09 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: No code Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: 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} Nov 02 15:59:09 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: No code Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: ControllerMpd::pushState Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::servicePushState Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: 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} Nov 02 15:59:09 volumio volumio[855]: verbose: CURRENT POSITION 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: No code Nov 02 15:59:09 volumio volumio[855]: info: CoreStateMachine::pushState Nov 02 15:59:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Nov 02 15:59:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Nov 02 15:59:09 volumio volumio[855]: info: ------------------------------ 475ms Nov 02 15:59:09 volumio volumio[855]: info: ------------------------------ 243ms Nov 02 15:59:09 volumio volumio[855]: info: ------------------------------ 241ms Nov 02 15:59:10 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:18 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:22 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:26 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:30 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:34 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:38 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:42 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:46 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:54 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:59:59 volumio volumio[855]: info: Enabling MyMusic plugin smart_inputs Nov 02 15:59:59 volumio volumio[855]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs Nov 02 15:59:59 volumio volumio[855]: info: [MyVolumio PluginManager] Plugin music_service smart_inputs not in user plan, not enabling Nov 02 15:59:59 volumio volumio[855]: info: Error: Plugin music_service smart_inputs not in user plan, not enabling Nov 02 15:59:59 volumio volumio[855]: error: Could not Enable MyMusic Plugin: Error Nov 02 16:00:02 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 16:00:06 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 16:00:10 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 16:00:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 16:00:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 02 16:00:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 02 16:00:15 volumio volumio[855]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 16:00:15 volumio volumio[855]: Error: dns service error: unknown Nov 02 16:00:15 volumio volumio[855]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Nov 02 16:00:15 volumio volumio[855]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Nov 02 16:00:15 volumio volumio[855]: errorCode: -65537 Nov 02 16:00:15 volumio volumio[855]: } Nov 02 16:00:15 volumio volumio[855]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 16:00:15 volumio sudo[2429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-02 15:59 Nov 02 16:00:15 volumio sudo[2429]: 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"