-- Logs begin at Sun 2024-10-06 01:00:33 UTC, end at Sun 2024-10-06 01:49:17 UTC. -- Oct 06 01:48:00 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:00 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 01:48:01 volumio volumio[818]: info: Retrieving Cloud Streaming UI Oct 06 01:48:01 volumio volumio[818]: info: Getting Tidal Cloud Configuration Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 01:48:01 volumio volumio[818]: info: Getting Qobuz Cloud Configuration Oct 06 01:48:01 volumio volumio[818]: info: Asking plugin for UI Config Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 01:48:01 volumio volumio[818]: info: Getting Spotify Cloud Configuration Oct 06 01:48:01 volumio volumio[818]: info: Asking plugin for UI Config Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 01:48:01 volumio volumio[818]: info: Saving Spotify Acccount Oct 06 01:48:01 volumio volumio[818]: info: Got Tidal Cloud Configuration Oct 06 01:48:01 volumio volumio[818]: info: Got it Oct 06 01:48:01 volumio volumio[818]: info: Got it Oct 06 01:48:01 volumio volumio[818]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 01:48:01 volumio volumio[818]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 01:48:01 volumio volumio[818]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 01:48:02 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:02 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 06 01:48:02 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand rescan Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand rescan took 2 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 101ms Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 101ms Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 100ms Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 99ms Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: Oct 06 01:48:03 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:03 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:03 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: 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 06 01:48:03 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: No code Oct 06 01:48:03 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:03 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:03 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 48ms Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 47ms Oct 06 01:48:03 volumio volumio[818]: info: ------------------------------ 46ms Oct 06 01:48:06 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand update Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand update took 1 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatetrue Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 41ms Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 41 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 40 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 114ms Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 75ms Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 74ms Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 75ms Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: Oct 06 01:48:09 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 26 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 25 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 25 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 24 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 24 milliseconds Oct 06 01:48:09 volumio volumio[818]: info: sendMpdCommand status took 6 milliseconds Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:09 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: 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 06 01:48:09 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: No code Oct 06 01:48:09 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:09 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:09 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 122ms Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 121ms Oct 06 01:48:09 volumio volumio[818]: info: ------------------------------ 121ms Oct 06 01:48:10 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:14 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:18 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:22 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:23 volumio kernel: usb 2-1.1: new high-speed USB device number 7 using ehci-pci Oct 06 01:48:23 volumio kernel: usb 2-1.1: New USB device found, idVendor=152d, idProduct=0901, bcdDevice= 3.03 Oct 06 01:48:23 volumio kernel: usb 2-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Oct 06 01:48:23 volumio kernel: usb 2-1.1: Product: SSD USB Drive Oct 06 01:48:23 volumio kernel: usb 2-1.1: Manufacturer: KOOTION Oct 06 01:48:23 volumio kernel: usb 2-1.1: SerialNumber: 00000000122D Oct 06 01:48:23 volumio kernel: usb-storage 2-1.1:1.0: USB Mass Storage device detected Oct 06 01:48:23 volumio kernel: scsi host4: usb-storage 2-1.1:1.0 Oct 06 01:48:23 volumio kernel: usbcore: registered new interface driver uas Oct 06 01:48:24 volumio kernel: scsi 4:0:0:0: Direct-Access KOOTION U21 0303 PQ: 0 ANSI: 6 Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: Attached scsi generic sg1 type 0 Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: [sdb] 500056057 512-byte logical blocks: (256 GB/238 GiB) Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: [sdb] Write Protect is off Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: [sdb] Mode Sense: 43 00 41 00 Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Oct 06 01:48:24 volumio kernel: sdb: sdb1 Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 06 01:48:24 volumio kernel: sd 4:0:0:0: [sdb] Attached SCSI removable disk Oct 06 01:48:24 volumio volumio[818]: info: Mounting Device A000-30C8 Oct 06 01:48:24 volumio sudo[2043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/A000-30C8 -o noatime Oct 06 01:48:24 volumio sudo[2043]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 01:48:24 volumio sudo[2043]: pam_unix(sudo:session): session closed for user root Oct 06 01:48:24 volumio volumio[818]: info: Scanning new location : "USB/A000-30C8" Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: info: Oct 06 01:48:24 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: info: Oct 06 01:48:24 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: info: Oct 06 01:48:24 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: info: Oct 06 01:48:24 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:24 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: info: Command Router : Notfying DB Updatetrue Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: info: Command Router : Notfying DB Updatetrue Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: info: Command Router : Notfying DB Updatetrue Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: info: Command Router : Notfying DB Updatetrue Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:24 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: 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 06 01:48:24 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: No code Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: 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 06 01:48:24 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: No code Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: 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 06 01:48:24 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: No code Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: 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 06 01:48:24 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: No code Oct 06 01:48:24 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:24 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:24 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:24 volumio volumio[818]: info: ------------------------------ 109ms Oct 06 01:48:24 volumio volumio[818]: info: ------------------------------ 109ms Oct 06 01:48:24 volumio volumio[818]: info: ------------------------------ 108ms Oct 06 01:48:24 volumio volumio[818]: info: ------------------------------ 108ms Oct 06 01:48:25 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 45ms Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 45ms Oct 06 01:48:25 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: Oct 06 01:48:25 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:25 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: 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 06 01:48:25 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: No code Oct 06 01:48:25 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:25 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:25 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 77ms Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 77ms Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 76ms Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 77ms Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 76ms Oct 06 01:48:25 volumio volumio[818]: info: ------------------------------ 76ms Oct 06 01:48:25 volumio kernel: usb 2-1.1: USB disconnect, device number 7 Oct 06 01:48:25 volumio sudo[2067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Oct 06 01:48:25 volumio sudo[2067]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 01:48:25 volumio systemd[1]: media-A000\x2d30C8.mount: Succeeded. Oct 06 01:48:25 volumio mount.exfat[2046]: failed to write super block Oct 06 01:48:25 volumio sudo[2067]: pam_unix(sudo:session): session closed for user root Oct 06 01:48:26 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:28 volumio kernel: usb 2-1.3: new high-speed USB device number 8 using ehci-pci Oct 06 01:48:28 volumio kernel: usb 2-1.3: device not accepting address 8, error -71 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:30 volumio volumio[818]: info: Scanning removed location : "USB/A000-30C8" Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 97ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 96ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 97ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 96ms Oct 06 01:48:30 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: MPD Database updated - AlbumList cache refreshed Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: database Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: Oct 06 01:48:30 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 101 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 101 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 101 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 5 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 6 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 5 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 5 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:30 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: 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 06 01:48:30 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: No code Oct 06 01:48:30 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:30 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:30 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 174ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 175ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 79ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 79ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 79ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 79ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 77ms Oct 06 01:48:30 volumio volumio[818]: info: ------------------------------ 78ms Oct 06 01:48:34 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:38 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 01:48:42 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:48:42 volumio volumio[818]: info: CURURI: music-library/USB Oct 06 01:48:42 volumio volumio[818]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand update Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand update took 1 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 86ms Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 85ms Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 84ms Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 83ms Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: Oct 06 01:48:45 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 3 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 2 milliseconds Oct 06 01:48:45 volumio volumio[818]: info: sendMpdCommand status took 1 milliseconds Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:48:45 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: 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 06 01:48:45 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: No code Oct 06 01:48:45 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:48:45 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:48:45 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 52ms Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 52ms Oct 06 01:48:45 volumio volumio[818]: info: ------------------------------ 51ms Oct 06 01:48:51 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:48:51 volumio volumio[818]: info: CURURI: music-library/USB Oct 06 01:48:51 volumio volumio[818]: error: Failed LSINFO: null Oct 06 01:48:53 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:48:53 volumio volumio[818]: info: CURURI: music-library/NAS Oct 06 01:48:53 volumio volumio[818]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 06 01:48:55 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:48:55 volumio volumio[818]: info: CURURI: music-library/INTERNAL Oct 06 01:48:55 volumio volumio[818]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 06 01:48:59 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:48:59 volumio volumio[818]: info: CURURI: music-library Oct 06 01:49:00 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:49:00 volumio volumio[818]: info: CURURI: music-library/USB Oct 06 01:49:00 volumio volumio[818]: error: Failed LSINFO: null Oct 06 01:49:04 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:49:04 volumio volumio[818]: info: CURURI: music-library/USB Oct 06 01:49:04 volumio volumio[818]: error: Failed LSINFO: null Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand update Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand update took 1 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 6 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 5 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 58ms Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 59 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 58 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 58 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 57 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 58 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 57 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 57 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 5 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 4 milliseconds Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 121ms Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 128ms Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 127ms Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 127ms Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 73ms Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: Oct 06 01:49:07 volumio volumio[818]: ---------------------------- MPD announces state update: update Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::getState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::sendMpdCommand status Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 14 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 13 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 12 milliseconds Oct 06 01:49:07 volumio volumio[818]: info: sendMpdCommand status took 11 milliseconds Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: Command Router : Notfying DB Updatefalse Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::Close All Modals sent Oct 06 01:49:07 volumio volumio[818]: verbose: ControllerMpd::parseState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ControllerMpd::pushState Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::servicePushState Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: 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 06 01:49:07 volumio volumio[818]: verbose: CURRENT POSITION 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState stateService stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::syncState currentStatus stop Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: No code Oct 06 01:49:07 volumio volumio[818]: info: CoreStateMachine::pushState Oct 06 01:49:07 volumio volumio[818]: info: CorePlayQueue::getTrack 0 Oct 06 01:49:07 volumio volumio[818]: info: CoreCommandRouter::volumioPushState Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 46ms Oct 06 01:49:07 volumio volumio[818]: info: ------------------------------ 45ms Oct 06 01:49:13 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:49:13 volumio volumio[818]: info: CURURI: music-library/USB Oct 06 01:49:13 volumio volumio[818]: error: Failed LSINFO: null Oct 06 01:49:15 volumio volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 01:49:15 volumio volumio[818]: info: CURURI: music-library Oct 06 01:49:16 volumio volumio[818]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 01:49:16 volumio volumio[818]: Error: connect ETIMEDOUT 157.240.10.32:443 Oct 06 01:49:16 volumio volumio[818]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 06 01:49:16 volumio volumio[818]: errno: -110, Oct 06 01:49:16 volumio volumio[818]: code: 'ETIMEDOUT', Oct 06 01:49:16 volumio volumio[818]: syscall: 'connect', Oct 06 01:49:16 volumio volumio[818]: address: '157.240.10.32', Oct 06 01:49:16 volumio volumio[818]: port: 443 Oct 06 01:49:16 volumio volumio[818]: } Oct 06 01:49:16 volumio volumio[818]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 01:49:17 volumio sudo[2132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 01:48 Oct 06 01:49:17 volumio sudo[2132]: 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="543f2de901f774399af6eae9d76f06fe4162e5dd" VOLUMIO_FE_VERSION="175efecbf4f79404c553a8a73d0a8929ba9e68ab" VOLUMIO_FE3_VERSION="9cf29de04cd974cb1504bd8ef33d64f591b09aef" VOLUMIO_BE_VERSION="0bba7bb5721ae1c828390745b52735c56d7c014a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 13 Dec 2021 04:23:43 PM CET" VOLUMIO_VERSION="3.175" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1a61a9a54138f16f76ebb97a307fc628"