-- Logs begin at Wed 2024-10-16 08:39:08 UTC, end at Wed 2024-10-16 08:41:51 UTC. -- Oct 16 08:40:00 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:04 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:07 volumio volumio[1006]: info: CoreCommandRouter::volumioGetState Oct 16 08:40:07 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 08:40:09 volumio volumio[1006]: info: Retrieving Cloud Streaming UI Oct 16 08:40:09 volumio volumio[1006]: info: Getting Tidal Cloud Configuration Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 08:40:09 volumio volumio[1006]: info: Getting Qobuz Cloud Configuration Oct 16 08:40:09 volumio volumio[1006]: info: Asking plugin for UI Config Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 08:40:09 volumio volumio[1006]: info: Getting Spotify Cloud Configuration Oct 16 08:40:09 volumio volumio[1006]: info: Asking plugin for UI Config Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 08:40:09 volumio volumio[1006]: info: Saving Spotify Acccount Oct 16 08:40:09 volumio volumio[1006]: info: Got Tidal Cloud Configuration Oct 16 08:40:09 volumio volumio[1006]: info: Got it Oct 16 08:40:09 volumio volumio[1006]: info: Got it Oct 16 08:40:09 volumio volumio[1006]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 08:40:09 volumio volumio[1006]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand rescan Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: Oct 16 08:40:13 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand rescan took 1 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: Command Router : Notfying DB Updatetrue Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: 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 16 08:40:13 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: No code Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: ------------------------------ 19ms Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: Oct 16 08:40:13 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: Oct 16 08:40:13 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: Oct 16 08:40:13 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: 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 16 08:40:13 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: No code Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: 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 16 08:40:13 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: No code Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: ------------------------------ 27ms Oct 16 08:40:13 volumio volumio[1006]: info: ------------------------------ 26ms Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: Oct 16 08:40:13 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: Oct 16 08:40:13 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 30 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 30 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 3 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 3 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 3 milliseconds Oct 16 08:40:13 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:13 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: 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 16 08:40:13 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: No code Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: 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 16 08:40:13 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: No code Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: 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 16 08:40:13 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: No code Oct 16 08:40:13 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:13 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:13 volumio volumio[1006]: info: ------------------------------ 58ms Oct 16 08:40:13 volumio volumio[1006]: info: ------------------------------ 32ms Oct 16 08:40:13 volumio volumio[1006]: info: ------------------------------ 32ms Oct 16 08:40:13 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand rescan Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: Oct 16 08:40:14 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand rescan took 1 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: Oct 16 08:40:14 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: Oct 16 08:40:14 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: Oct 16 08:40:14 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 3 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: 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 16 08:40:14 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: No code Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: 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 16 08:40:14 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: No code Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: 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 16 08:40:14 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: No code Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: ------------------------------ 42ms Oct 16 08:40:14 volumio volumio[1006]: info: ------------------------------ 42ms Oct 16 08:40:14 volumio volumio[1006]: info: ------------------------------ 42ms Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: Oct 16 08:40:14 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: Oct 16 08:40:14 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 43 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 43 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:14 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:14 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: 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 16 08:40:14 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: No code Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: 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 16 08:40:14 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: No code Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: 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 16 08:40:14 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: No code Oct 16 08:40:14 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:14 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:14 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:14 volumio volumio[1006]: info: ------------------------------ 73ms Oct 16 08:40:14 volumio volumio[1006]: info: ------------------------------ 31ms Oct 16 08:40:14 volumio volumio[1006]: info: ------------------------------ 30ms Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand update Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: Oct 16 08:40:15 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand update took 0 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: Oct 16 08:40:15 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: 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 16 08:40:15 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: No code Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: ------------------------------ 29ms Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: Oct 16 08:40:15 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: Oct 16 08:40:15 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 30 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 29 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: 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 16 08:40:15 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: No code Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: 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 16 08:40:15 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: No code Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: 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 16 08:40:15 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: No code Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: ------------------------------ 58ms Oct 16 08:40:15 volumio volumio[1006]: info: ------------------------------ 29ms Oct 16 08:40:15 volumio volumio[1006]: info: ------------------------------ 29ms Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: Oct 16 08:40:15 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: Oct 16 08:40:15 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 4 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 3 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:15 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:15 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: 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 16 08:40:15 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: No code Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: 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 16 08:40:15 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: No code Oct 16 08:40:15 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:15 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:15 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:15 volumio volumio[1006]: info: ------------------------------ 21ms Oct 16 08:40:15 volumio volumio[1006]: info: ------------------------------ 20ms Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand update Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: Oct 16 08:40:16 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand update took 1 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: Oct 16 08:40:16 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: 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 16 08:40:16 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: No code Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: ------------------------------ 13ms Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: Oct 16 08:40:16 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: Oct 16 08:40:16 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 14 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 14 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 1 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 0 milliseconds Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: 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 16 08:40:16 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: No code Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: 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 16 08:40:16 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: No code Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: 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 16 08:40:16 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: No code Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: ------------------------------ 46ms Oct 16 08:40:16 volumio volumio[1006]: info: ------------------------------ 33ms Oct 16 08:40:16 volumio volumio[1006]: info: ------------------------------ 32ms Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: Oct 16 08:40:16 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: Oct 16 08:40:16 volumio volumio[1006]: ---------------------------- MPD announces state update: update Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::getState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:16 volumio volumio[1006]: info: sendMpdCommand status took 2 milliseconds Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: Command Router : Notfying DB Updatefalse Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::Close All Modals sent Oct 16 08:40:16 volumio volumio[1006]: verbose: ControllerMpd::parseState Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: 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 16 08:40:16 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: No code Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: ControllerMpd::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: 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 16 08:40:16 volumio volumio[1006]: verbose: CURRENT POSITION 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState stateService stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: No code Oct 16 08:40:16 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:40:16 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:40:16 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:40:16 volumio volumio[1006]: info: ------------------------------ 22ms Oct 16 08:40:16 volumio volumio[1006]: info: ------------------------------ 22ms Oct 16 08:40:17 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:17 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 16 08:40:17 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 16 08:40:21 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:24 volumio ntpd[1792]: Soliciting pool server 78.46.102.180 Oct 16 08:40:25 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:25 volumio ntpd[1792]: Soliciting pool server 116.203.151.74 Oct 16 08:40:25 volumio ntpd[1792]: Soliciting pool server 108.59.2.24 Oct 16 08:40:29 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:33 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:37 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:41 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:45 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:49 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:53 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:40:57 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:01 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:05 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:09 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:13 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:17 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:21 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:25 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:29 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:33 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:37 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:41 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:45 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:48 volumio volumio[1006]: info: Airplay started streaming, receiving metadatas Oct 16 08:41:48 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:41:48 volumio volumio[1006]: info: CoreCommandRouter::volumioStop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::stop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio volumio[1006]: info: Airplay started streaming, receiving metadatas Oct 16 08:41:48 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:41:48 volumio volumio[1006]: info: CoreCommandRouter::volumioStop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::stop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio volumio[1006]: info: Airplay started streaming, receiving metadatas Oct 16 08:41:48 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:41:48 volumio volumio[1006]: info: CoreCommandRouter::volumioStop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::stop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio shairport-sync[1460]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 16 08:41:48 volumio shairport-sync[1460]: Dload Upload Total Spent Left Speed Oct 16 08:41:48 volumio volumio[1006]: info: Oct 16 08:41:48 volumio volumio[1006]: ---------------------------- Client requests Start Airplay PlaybackRoutine Oct 16 08:41:48 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Oct 16 08:41:48 volumio volumio[1006]: info: Airplay playback start Oct 16 08:41:48 volumio volumio[1006]: info: CorePlayQueue::getTrack 0 Oct 16 08:41:48 volumio volumio[1006]: info: CoreCommandRouter::volumioStop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::stop Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:41:48 volumio shairport-sync[1460]: [158B blob data] Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:49 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::servicePushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreStateMachine::pushState Oct 16 08:41:50 volumio volumio[1006]: info: CoreCommandRouter::volumioPushState Oct 16 08:41:51 volumio volumio[1006]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 08:41:51 volumio volumio[1006]: Error: connect ECONNREFUSED 47.88.58.234:443 Oct 16 08:41:51 volumio volumio[1006]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 16 08:41:51 volumio volumio[1006]: errno: -111, Oct 16 08:41:51 volumio volumio[1006]: code: 'ECONNREFUSED', Oct 16 08:41:51 volumio volumio[1006]: syscall: 'connect', Oct 16 08:41:51 volumio volumio[1006]: address: '47.88.58.234', Oct 16 08:41:51 volumio volumio[1006]: port: 443 Oct 16 08:41:51 volumio volumio[1006]: } Oct 16 08:41:51 volumio volumio[1006]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 08:41:51 volumio sudo[2106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 08:40 Oct 16 08:41:51 volumio sudo[2106]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"