-- Logs begin at Thu 2019-02-14 10:12:00 UTC, end at Mon 2025-04-14 18:58:08 UTC. -- Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 18:57:00 volumioak volumio[1057]: info: Retrieving Cloud Streaming UI Apr 14 18:57:00 volumioak volumio[1057]: info: Getting Tidal Cloud Configuration Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 18:57:00 volumioak volumio[1057]: info: Getting Qobuz Cloud Configuration Apr 14 18:57:00 volumioak volumio[1057]: info: Asking plugin for UI Config Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 18:57:00 volumioak volumio[1057]: info: Getting Spotify Cloud Configuration Apr 14 18:57:00 volumioak volumio[1057]: info: Asking plugin for UI Config Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 18:57:00 volumioak volumio[1057]: info: Saving Spotify Acccount Apr 14 18:57:00 volumioak volumio[1057]: info: Got Tidal Cloud Configuration Apr 14 18:57:00 volumioak volumio[1057]: info: Got it Apr 14 18:57:00 volumioak volumio[1057]: info: Got it Apr 14 18:57:00 volumioak volumio[1057]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 18:57:00 volumioak volumio[1057]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioGetBrowseSources Apr 14 18:57:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:01 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 18:57:01 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:05 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:05 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 14 18:57:05 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand update Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand update took 9 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 9 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 4 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: Command Router : Notfying DB Updatetrue Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 135ms Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: MPD Database updated - AlbumList cache refreshed Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: database Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 15 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 15 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 9 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 9 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 154ms Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 148ms Apr 14 18:57:06 volumioak volumio[1057]: info: MPD Database updated - AlbumList cache refreshed Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: database Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: MPD Database updated - AlbumList cache refreshed Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: database Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: Apr 14 18:57:06 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 181 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 180 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 179 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 37 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 35 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 35 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 33 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 32 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: info: sendMpdCommand status took 32 milliseconds Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: 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} Apr 14 18:57:06 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: No code Apr 14 18:57:06 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:06 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:06 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 481ms Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 482ms Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 339ms Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 339ms Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 336ms Apr 14 18:57:06 volumioak volumio[1057]: info: ------------------------------ 336ms Apr 14 18:57:07 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 14 18:57:07 volumioak volumio[1057]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 14 18:57:07 volumioak volumio[1057]: info: Received Get System Version Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 14 18:57:07 volumioak volumio[1057]: info: Received Get System Info Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:57:07 volumioak volumio[1057]: info: Discovery: Getting this device information Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::volumioGetState Apr 14 18:57:07 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:57:07 volumioak volumio[1628]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Apr 14 18:57:08 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:10 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:57:10 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:57:10 volumioak volumio[1057]: info: Discovery: Getting this device information Apr 14 18:57:10 volumioak volumio[1057]: info: CoreCommandRouter::volumioGetState Apr 14 18:57:10 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:10 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:57:12 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:13 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:16 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:18 volumioak volumio[1628]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Apr 14 18:57:18 volumioak volumio[1628]: stack backtrace: Apr 14 18:57:18 volumioak volumio[1628]: 0: 0xa48444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Apr 14 18:57:18 volumioak volumio[1628]: 1: 0xa48444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Apr 14 18:57:18 volumioak volumio[1628]: 2: 0xa48444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 Apr 14 18:57:18 volumioak volumio[1628]: 3: 0xa48444 - ::fmt::h33b23b1d14f668ff Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 Apr 14 18:57:18 volumioak volumio[1628]: 4: 0xa710dc - core::fmt::write::h6320fb0e6ac90e58 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 Apr 14 18:57:18 volumioak volumio[1628]: 5: 0xa404c4 - std::io::Write::write_fmt::h33b25d4810ca481f Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 Apr 14 18:57:18 volumioak volumio[1628]: 6: 0xa4aef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 Apr 14 18:57:18 volumioak volumio[1628]: 7: 0xa4aef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 Apr 14 18:57:18 volumioak volumio[1628]: 8: 0xa4aef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 Apr 14 18:57:18 volumioak volumio[1628]: 9: 0xa4ab14 - std::panicking::default_hook::hcbdb3b7c40dca30c Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9 Apr 14 18:57:18 volumioak volumio[1628]: 10: 0xa4b694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 Apr 14 18:57:18 volumioak volumio[1628]: 11: 0xa4b304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 Apr 14 18:57:18 volumioak volumio[1628]: 12: 0xa489c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 Apr 14 18:57:18 volumioak volumio[1628]: 13: 0xa4b098 - rust_begin_unwind Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 Apr 14 18:57:18 volumioak volumio[1628]: 14: 0x52e6f4 - core::panicking::panic_fmt::h84c42730e4a50809 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 Apr 14 18:57:18 volumioak volumio[1628]: 15: 0x71a930 - futures::future::chain::Chain::poll::hb08394d341f2da5e Apr 14 18:57:18 volumioak volumio[1628]: 16: 0x798d4c - as futures::future::Future>::poll::h0222f8b810b74ccb Apr 14 18:57:18 volumioak volumio[1628]: 17: 0x71b53c - futures::future::chain::Chain::poll::hd3215a5f3268adbc Apr 14 18:57:18 volumioak volumio[1628]: 18: 0x7915f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a Apr 14 18:57:18 volumioak volumio[1628]: 19: 0x555b34 - ::poll::h5fd9e3bcdeb25ad9 Apr 14 18:57:18 volumioak volumio[1628]: 20: 0x5733dc - futures::task_impl::std::set::h8f754e80bd562d0a Apr 14 18:57:18 volumioak volumio[1628]: 21: 0x58a42c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0 Apr 14 18:57:18 volumioak volumio[1628]: 22: 0x56f99c - tokio_current_thread::Entered

::block_on::hde55cdf28eabe6d5 Apr 14 18:57:18 volumioak volumio[1628]: 23: 0x58a6f0 - std::thread::local::LocalKey::with::hedba3cfe41326627 Apr 14 18:57:18 volumioak volumio[1628]: 24: 0x572880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8 Apr 14 18:57:18 volumioak volumio[1628]: 25: 0x558eb0 - vollibrespot::main::h35555355ed947dd1 Apr 14 18:57:18 volumioak volumio[1628]: 26: 0x578c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a Apr 14 18:57:18 volumioak volumio[1628]: 27: 0x59e52c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072 Apr 14 18:57:18 volumioak volumio[1628]: 28: 0xa47b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13 Apr 14 18:57:18 volumioak volumio[1628]: 29: 0xa47b28 - std::panicking::try::do_call::hdf194554a41aa3cc Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Apr 14 18:57:18 volumioak volumio[1628]: 30: 0xa47b28 - std::panicking::try::hbf4b7be9f9ffa5f8 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Apr 14 18:57:18 volumioak volumio[1628]: 31: 0xa47b28 - std::panic::catch_unwind::h45f392a39f2fe48c Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Apr 14 18:57:18 volumioak volumio[1628]: 32: 0xa47b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48 Apr 14 18:57:18 volumioak volumio[1628]: 33: 0xa47b28 - std::panicking::try::do_call::hd126f715b519ff2a Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Apr 14 18:57:18 volumioak volumio[1628]: 34: 0xa47b28 - std::panicking::try::h80b7148ce71893dc Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Apr 14 18:57:18 volumioak volumio[1628]: 35: 0xa47b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Apr 14 18:57:18 volumioak volumio[1628]: 36: 0xa47b28 - std::rt::lang_start_internal::h3daa586a0b835507 Apr 14 18:57:18 volumioak volumio[1628]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20 Apr 14 18:57:18 volumioak volumio[1628]: 37: 0x55ae80 - main Apr 14 18:57:18 volumioak volumio[1628]: 38: 0x76bf8768 - __libc_start_main Apr 14 18:57:18 volumioak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a Apr 14 18:57:18 volumioak systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Apr 14 18:57:18 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:20 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Apr 14 18:57:20 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 8. Apr 14 18:57:20 volumioak systemd[1]: Stopped Volspotconnect2 Daemon. Apr 14 18:57:20 volumioak systemd[1]: Started Volspotconnect2 Daemon. Apr 14 18:57:20 volumioak volumio[1648]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 14 18:57:20 volumioak volumio[1648]: Reading Config from "/tmp/volspotify.toml" Apr 14 18:57:20 volumioak volumio[1648]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 14 18:57:20 volumioak volumio[1648]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 14 18:57:20 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand update Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: Apr 14 18:57:22 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand update took 5 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: Apr 14 18:57:22 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 5 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 3 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: 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} Apr 14 18:57:22 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: No code Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: ------------------------------ 103ms Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: Apr 14 18:57:22 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: Apr 14 18:57:22 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 108 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 108 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 7 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 5 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 5 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 4 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: 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} Apr 14 18:57:22 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: No code Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: 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} Apr 14 18:57:22 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: No code Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: 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} Apr 14 18:57:22 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: No code Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: ------------------------------ 322ms Apr 14 18:57:22 volumioak volumio[1057]: info: ------------------------------ 222ms Apr 14 18:57:22 volumioak volumio[1057]: info: ------------------------------ 220ms Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: Apr 14 18:57:22 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: Apr 14 18:57:22 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 33 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 33 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 32 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: info: sendMpdCommand status took 31 milliseconds Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:22 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: 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} Apr 14 18:57:22 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: No code Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: 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} Apr 14 18:57:22 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: No code Apr 14 18:57:22 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:22 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:22 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:22 volumioak volumio[1057]: info: ------------------------------ 168ms Apr 14 18:57:22 volumioak volumio[1057]: info: ------------------------------ 167ms Apr 14 18:57:24 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:24 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:28 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:29 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:31 volumioak volumio[1648]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Apr 14 18:57:32 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:35 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand rescan Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: Apr 14 18:57:36 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand rescan took 4 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: Apr 14 18:57:36 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: Apr 14 18:57:36 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: Apr 14 18:57:36 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 10 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 8 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 8 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 7 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 6 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 6 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: 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} Apr 14 18:57:36 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: No code Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: 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} Apr 14 18:57:36 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: No code Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: 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} Apr 14 18:57:36 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: No code Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: ------------------------------ 208ms Apr 14 18:57:36 volumioak volumio[1057]: info: ------------------------------ 207ms Apr 14 18:57:36 volumioak volumio[1057]: info: ------------------------------ 206ms Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: Apr 14 18:57:36 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: Apr 14 18:57:36 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 212 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 210 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 7 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 6 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 5 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: info: sendMpdCommand status took 5 milliseconds Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:57:36 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: 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} Apr 14 18:57:36 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: No code Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: 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} Apr 14 18:57:36 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: No code Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: 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} Apr 14 18:57:36 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: No code Apr 14 18:57:36 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:57:36 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:36 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:57:36 volumioak volumio[1057]: info: ------------------------------ 441ms Apr 14 18:57:36 volumioak volumio[1057]: info: ------------------------------ 237ms Apr 14 18:57:36 volumioak volumio[1057]: info: ------------------------------ 236ms Apr 14 18:57:37 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:39 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:57:39 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:57:39 volumioak volumio[1057]: info: Discovery: Getting this device information Apr 14 18:57:39 volumioak volumio[1057]: info: CoreCommandRouter::volumioGetState Apr 14 18:57:39 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:57:39 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:57:40 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:41 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:41 volumioak volumio[1648]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Apr 14 18:57:41 volumioak volumio[1648]: stack backtrace: Apr 14 18:57:41 volumioak volumio[1648]: 0: 0xa38444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Apr 14 18:57:41 volumioak volumio[1648]: 1: 0xa38444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Apr 14 18:57:41 volumioak volumio[1648]: 2: 0xa38444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 Apr 14 18:57:41 volumioak volumio[1648]: 3: 0xa38444 - ::fmt::h33b23b1d14f668ff Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 Apr 14 18:57:41 volumioak volumio[1648]: 4: 0xa610dc - core::fmt::write::h6320fb0e6ac90e58 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 Apr 14 18:57:41 volumioak volumio[1648]: 5: 0xa304c4 - std::io::Write::write_fmt::h33b25d4810ca481f Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 Apr 14 18:57:41 volumioak volumio[1648]: 6: 0xa3aef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 Apr 14 18:57:41 volumioak volumio[1648]: 7: 0xa3aef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 Apr 14 18:57:41 volumioak volumio[1648]: 8: 0xa3aef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 Apr 14 18:57:41 volumioak volumio[1648]: 9: 0xa3ab14 - std::panicking::default_hook::hcbdb3b7c40dca30c Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9 Apr 14 18:57:41 volumioak volumio[1648]: 10: 0xa3b694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 Apr 14 18:57:41 volumioak volumio[1648]: 11: 0xa3b304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 Apr 14 18:57:41 volumioak volumio[1648]: 12: 0xa389c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 Apr 14 18:57:41 volumioak volumio[1648]: 13: 0xa3b098 - rust_begin_unwind Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 Apr 14 18:57:41 volumioak volumio[1648]: 14: 0x51e6f4 - core::panicking::panic_fmt::h84c42730e4a50809 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 Apr 14 18:57:41 volumioak volumio[1648]: 15: 0x70a930 - futures::future::chain::Chain::poll::hb08394d341f2da5e Apr 14 18:57:41 volumioak volumio[1648]: 16: 0x788d4c - as futures::future::Future>::poll::h0222f8b810b74ccb Apr 14 18:57:41 volumioak volumio[1648]: 17: 0x70b53c - futures::future::chain::Chain::poll::hd3215a5f3268adbc Apr 14 18:57:41 volumioak volumio[1648]: 18: 0x7815f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a Apr 14 18:57:41 volumioak volumio[1648]: 19: 0x545b34 - ::poll::h5fd9e3bcdeb25ad9 Apr 14 18:57:41 volumioak volumio[1648]: 20: 0x5633dc - futures::task_impl::std::set::h8f754e80bd562d0a Apr 14 18:57:41 volumioak volumio[1648]: 21: 0x57a42c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0 Apr 14 18:57:41 volumioak volumio[1648]: 22: 0x55f99c - tokio_current_thread::Entered

::block_on::hde55cdf28eabe6d5 Apr 14 18:57:41 volumioak volumio[1648]: 23: 0x57a6f0 - std::thread::local::LocalKey::with::hedba3cfe41326627 Apr 14 18:57:41 volumioak volumio[1648]: 24: 0x562880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8 Apr 14 18:57:41 volumioak volumio[1648]: 25: 0x548eb0 - vollibrespot::main::h35555355ed947dd1 Apr 14 18:57:41 volumioak volumio[1648]: 26: 0x568c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a Apr 14 18:57:41 volumioak volumio[1648]: 27: 0x58e52c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072 Apr 14 18:57:41 volumioak volumio[1648]: 28: 0xa37b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13 Apr 14 18:57:41 volumioak volumio[1648]: 29: 0xa37b28 - std::panicking::try::do_call::hdf194554a41aa3cc Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Apr 14 18:57:41 volumioak volumio[1648]: 30: 0xa37b28 - std::panicking::try::hbf4b7be9f9ffa5f8 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Apr 14 18:57:41 volumioak volumio[1648]: 31: 0xa37b28 - std::panic::catch_unwind::h45f392a39f2fe48c Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Apr 14 18:57:41 volumioak volumio[1648]: 32: 0xa37b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48 Apr 14 18:57:41 volumioak volumio[1648]: 33: 0xa37b28 - std::panicking::try::do_call::hd126f715b519ff2a Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Apr 14 18:57:41 volumioak volumio[1648]: 34: 0xa37b28 - std::panicking::try::h80b7148ce71893dc Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Apr 14 18:57:41 volumioak volumio[1648]: 35: 0xa37b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Apr 14 18:57:41 volumioak volumio[1648]: 36: 0xa37b28 - std::rt::lang_start_internal::h3daa586a0b835507 Apr 14 18:57:41 volumioak volumio[1648]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20 Apr 14 18:57:41 volumioak volumio[1648]: 37: 0x54ae80 - main Apr 14 18:57:41 volumioak volumio[1648]: 38: 0x76bf2768 - __libc_start_main Apr 14 18:57:41 volumioak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a Apr 14 18:57:41 volumioak systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Apr 14 18:57:44 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Apr 14 18:57:44 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 9. Apr 14 18:57:44 volumioak systemd[1]: Stopped Volspotconnect2 Daemon. Apr 14 18:57:44 volumioak systemd[1]: Started Volspotconnect2 Daemon. Apr 14 18:57:44 volumioak volumio[1722]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 14 18:57:44 volumioak volumio[1722]: Reading Config from "/tmp/volspotify.toml" Apr 14 18:57:44 volumioak volumio[1722]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 14 18:57:44 volumioak volumio[1722]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 14 18:57:44 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:46 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:48 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:52 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:57:52 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:54 volumioak volumio[1722]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Apr 14 18:57:56 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:57:58 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand rescan Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: Apr 14 18:58:00 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand rescan took 5 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: Apr 14 18:58:00 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: Apr 14 18:58:00 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: Apr 14 18:58:00 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 14 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 13 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 12 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 10 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 10 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 6 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: 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} Apr 14 18:58:00 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: No code Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: 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} Apr 14 18:58:00 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: No code Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: 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} Apr 14 18:58:00 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: No code Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: ------------------------------ 254ms Apr 14 18:58:00 volumioak volumio[1057]: info: ------------------------------ 252ms Apr 14 18:58:00 volumioak volumio[1057]: info: ------------------------------ 251ms Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: Apr 14 18:58:00 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: Apr 14 18:58:00 volumioak volumio[1057]: ---------------------------- MPD announces state update: update Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::getState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::sendMpdCommand status Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 256 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 255 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 10 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 9 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 7 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: info: sendMpdCommand status took 6 milliseconds Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: Command Router : Notfying DB Updatefalse Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::Close All Modals sent Apr 14 18:58:00 volumioak volumio[1057]: verbose: ControllerMpd::parseState Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: 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} Apr 14 18:58:00 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: No code Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: 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} Apr 14 18:58:00 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: No code Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: ControllerMpd::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::servicePushState Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: 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} Apr 14 18:58:00 volumioak volumio[1057]: verbose: CURRENT POSITION 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState stateService stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::syncState currentStatus stop Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: No code Apr 14 18:58:00 volumioak volumio[1057]: info: CoreStateMachine::pushState Apr 14 18:58:00 volumioak volumio[1057]: info: CorePlayQueue::getTrack 0 Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::volumioPushState Apr 14 18:58:00 volumioak volumio[1057]: info: ------------------------------ 481ms Apr 14 18:58:00 volumioak volumio[1057]: info: ------------------------------ 240ms Apr 14 18:58:00 volumioak volumio[1057]: info: ------------------------------ 237ms Apr 14 18:58:00 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:58:03 volumioak wpa_supplicant[894]: wlan0: Failed to initiate sched scan Apr 14 18:58:04 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 14 18:58:05 volumioak volumio[1722]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Apr 14 18:58:05 volumioak volumio[1722]: stack backtrace: Apr 14 18:58:05 volumioak volumio[1722]: 0: 0x9c8444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Apr 14 18:58:05 volumioak volumio[1722]: 1: 0x9c8444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Apr 14 18:58:05 volumioak volumio[1722]: 2: 0x9c8444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 Apr 14 18:58:05 volumioak volumio[1722]: 3: 0x9c8444 - ::fmt::h33b23b1d14f668ff Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 Apr 14 18:58:05 volumioak volumio[1722]: 4: 0x9f10dc - core::fmt::write::h6320fb0e6ac90e58 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 Apr 14 18:58:05 volumioak volumio[1722]: 5: 0x9c04c4 - std::io::Write::write_fmt::h33b25d4810ca481f Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 Apr 14 18:58:05 volumioak volumio[1722]: 6: 0x9caef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 Apr 14 18:58:05 volumioak volumio[1722]: 7: 0x9caef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 Apr 14 18:58:05 volumioak volumio[1722]: 8: 0x9caef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 Apr 14 18:58:05 volumioak volumio[1722]: 9: 0x9cab14 - std::panicking::default_hook::hcbdb3b7c40dca30c Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9 Apr 14 18:58:05 volumioak volumio[1722]: 10: 0x9cb694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 Apr 14 18:58:05 volumioak volumio[1722]: 11: 0x9cb304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 Apr 14 18:58:05 volumioak volumio[1722]: 12: 0x9c89c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 Apr 14 18:58:05 volumioak volumio[1722]: 13: 0x9cb098 - rust_begin_unwind Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 Apr 14 18:58:05 volumioak volumio[1722]: 14: 0x4ae6f4 - core::panicking::panic_fmt::h84c42730e4a50809 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 Apr 14 18:58:05 volumioak volumio[1722]: 15: 0x69a930 - futures::future::chain::Chain::poll::hb08394d341f2da5e Apr 14 18:58:05 volumioak volumio[1722]: 16: 0x718d4c - as futures::future::Future>::poll::h0222f8b810b74ccb Apr 14 18:58:05 volumioak volumio[1722]: 17: 0x69b53c - futures::future::chain::Chain::poll::hd3215a5f3268adbc Apr 14 18:58:05 volumioak volumio[1722]: 18: 0x7115f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a Apr 14 18:58:05 volumioak volumio[1722]: 19: 0x4d5b34 - ::poll::h5fd9e3bcdeb25ad9 Apr 14 18:58:05 volumioak volumio[1722]: 20: 0x4f33dc - futures::task_impl::std::set::h8f754e80bd562d0a Apr 14 18:58:05 volumioak volumio[1722]: 21: 0x50a42c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0 Apr 14 18:58:05 volumioak volumio[1722]: 22: 0x4ef99c - tokio_current_thread::Entered

::block_on::hde55cdf28eabe6d5 Apr 14 18:58:05 volumioak volumio[1722]: 23: 0x50a6f0 - std::thread::local::LocalKey::with::hedba3cfe41326627 Apr 14 18:58:05 volumioak volumio[1722]: 24: 0x4f2880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8 Apr 14 18:58:05 volumioak volumio[1722]: 25: 0x4d8eb0 - vollibrespot::main::h35555355ed947dd1 Apr 14 18:58:05 volumioak volumio[1722]: 26: 0x4f8c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a Apr 14 18:58:05 volumioak volumio[1722]: 27: 0x51e52c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072 Apr 14 18:58:05 volumioak volumio[1722]: 28: 0x9c7b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13 Apr 14 18:58:05 volumioak volumio[1722]: 29: 0x9c7b28 - std::panicking::try::do_call::hdf194554a41aa3cc Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Apr 14 18:58:05 volumioak volumio[1722]: 30: 0x9c7b28 - std::panicking::try::hbf4b7be9f9ffa5f8 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Apr 14 18:58:05 volumioak volumio[1722]: 31: 0x9c7b28 - std::panic::catch_unwind::h45f392a39f2fe48c Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Apr 14 18:58:05 volumioak volumio[1722]: 32: 0x9c7b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48 Apr 14 18:58:05 volumioak volumio[1722]: 33: 0x9c7b28 - std::panicking::try::do_call::hd126f715b519ff2a Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Apr 14 18:58:05 volumioak volumio[1722]: 34: 0x9c7b28 - std::panicking::try::h80b7148ce71893dc Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Apr 14 18:58:05 volumioak volumio[1722]: 35: 0x9c7b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Apr 14 18:58:05 volumioak volumio[1722]: 36: 0x9c7b28 - std::rt::lang_start_internal::h3daa586a0b835507 Apr 14 18:58:05 volumioak volumio[1722]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20 Apr 14 18:58:05 volumioak volumio[1722]: 37: 0x4dae80 - main Apr 14 18:58:05 volumioak volumio[1722]: 38: 0x76c92768 - __libc_start_main Apr 14 18:58:05 volumioak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a Apr 14 18:58:05 volumioak systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Apr 14 18:58:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 14 18:58:07 volumioak volumio[1057]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 14 18:58:07 volumioak volumio[1057]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 18:58:07 volumioak volumio[1057]: Error: getaddrinfo -3007 Apr 14 18:58:07 volumioak volumio[1057]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Apr 14 18:58:07 volumioak volumio[1057]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Apr 14 18:58:07 volumioak volumio[1057]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Apr 14 18:58:07 volumioak volumio[1057]: code: -3007, Apr 14 18:58:07 volumioak volumio[1057]: errno: -3007, Apr 14 18:58:07 volumioak volumio[1057]: syscall: 'getaddrinfo' Apr 14 18:58:07 volumioak volumio[1057]: } Apr 14 18:58:07 volumioak volumio[1057]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 18:58:07 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Apr 14 18:58:07 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 10. Apr 14 18:58:07 volumioak systemd[1]: Stopped Volspotconnect2 Daemon. Apr 14 18:58:07 volumioak systemd[1]: Started Volspotconnect2 Daemon. Apr 14 18:58:07 volumioak volumio[1752]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 14 18:58:07 volumioak volumio[1752]: Reading Config from "/tmp/volspotify.toml" Apr 14 18:58:07 volumioak volumio[1752]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 14 18:58:07 volumioak volumio[1752]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 14 18:58:08 volumioak sudo[1759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-14 18:57 Apr 14 18:58:08 volumioak sudo[1759]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"