-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2024-09-09 15:17:43 CST. -- Sep 09 15:16:00 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:00 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:00 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:00 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:00 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:01 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:01 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:01 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:01 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:01 volumio sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/Lexar Sep 09 15:16:01 volumio sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:01 volumio systemd[1]: media-Lexar.mount: Succeeded. Sep 09 15:16:02 volumio sudo[1372]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , updateMpdDB Sep 09 15:16:02 volumio volumio[798]: info: Update mpd DB Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: MPD Database updated - AlbumList cache refreshed Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: database Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: MPD Database updated - AlbumList cache refreshed Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: database Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: MPD Database updated - AlbumList cache refreshed Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: database Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand update took 152 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 132 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 131 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 131 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 131 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 131 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 131 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 17 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 17 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 17 milliseconds Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 233ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 233ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 233ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 120ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 120ms Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 125 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 125 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 126 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 125 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 125 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 110 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 110 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 111 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 7 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 6 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 6 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 6 milliseconds Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 275ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 276ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 275ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 275ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 276ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 157ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 156ms Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:16:02 volumio volumio[798]: info: CURURI: music-library/USB Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: Sep 09 15:16:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 173 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 170 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:02 volumio volumio[798]: info: sendMpdCommand status took 0 milliseconds Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: 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} Sep 09 15:16:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: No code Sep 09 15:16:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 274ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 102ms Sep 09 15:16:02 volumio volumio[798]: info: ------------------------------ 104ms Sep 09 15:16:03 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:03 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:03 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:03 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:03 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:04 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:04 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:04 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:04 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:04 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:05 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:05 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:05 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:05 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:05 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:05 volumio sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/music Sep 09 15:16:05 volumio sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:05 volumio sudo[1406]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:05 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/music Sep 09 15:16:05 volumio volumio[798]: umount: /mnt/USB/music: not mounted. Sep 09 15:16:05 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/music"} Sep 09 15:16:06 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:06 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:06 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:06 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:06 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:07 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:07 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:07 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:07 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:07 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:07 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:16:07 volumio volumio[798]: info: CURURI: music-library/USB/music Sep 09 15:16:07 volumio volumio[798]: error: Failed LSINFO: null Sep 09 15:16:07 volumio volumio[798]: info: Preload queue cleared Sep 09 15:16:08 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:08 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:08 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:08 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:08 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:09 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:09 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:09 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:09 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:09 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:10 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:10 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:10 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:10 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:10 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:11 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:11 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:11 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:11 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:11 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:11 volumio sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/music Sep 09 15:16:11 volumio sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:11 volumio sudo[1410]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:11 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/music Sep 09 15:16:11 volumio volumio[798]: umount: /mnt/USB/music: not mounted. Sep 09 15:16:11 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/music"} Sep 09 15:16:12 volumio volumio[798]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 15:16:12 volumio volumio[798]: info: Retrying Login Due to Network Error Sep 09 15:16:12 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:12 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:12 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:12 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:12 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:13 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:13 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:13 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:13 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:14 volumio sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/28DD-B66B Sep 09 15:16:14 volumio sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:14 volumio sudo[1413]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:14 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/28DD-B66B Sep 09 15:16:14 volumio volumio[798]: umount: /mnt/USB/28DD-B66B: not mounted. Sep 09 15:16:14 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/28DD-B66B"} Sep 09 15:16:14 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:14 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:14 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:14 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:14 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:15 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:15 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:15 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:15 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:15 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:16 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:16 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:16 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:16 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:16 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:17 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:17 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:17 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:17 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:17 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:18 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:18 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:18 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:18 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:18 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:19 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:19 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:19 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:19 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:19 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:20 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:20 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:20 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:20 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:20 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:21 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:21 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:21 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:21 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:21 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:22 volumio volumio[798]: info: MyVolumio login type: Token Sep 09 15:16:22 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:22 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:22 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:22 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:22 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:23 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:23 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:23 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:23 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:23 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:24 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:24 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:24 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:24 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:24 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:25 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:25 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:25 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:25 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:25 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:26 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:26 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:26 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:26 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:26 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:27 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:27 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:27 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:27 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:27 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:28 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:28 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:28 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:28 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:28 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:29 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:29 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:29 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:29 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:29 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:30 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:30 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:30 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:30 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:30 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:31 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:31 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:31 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:31 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:31 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:32 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:32 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:32 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:32 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:32 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:33 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:33 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:33 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:33 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:33 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:34 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:34 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:34 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:34 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:34 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:34 volumio kernel: usb 4-1: USB disconnect, device number 2 Sep 09 15:16:34 volumio volumio[798]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb4/4-1/4-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/000039ea-01 /dev/disk/by-id/usb-Lexar_SL500_2024R30356000145-0:0-part1 /dev/disk/by-label/Lexar /dev/disk/by-uuid/3C7D-0383 /dev/disk/by-path/platform-xhci-hcd.1-usb-0:1:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb4/4-1/4-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"28","ID_BUS":"usb","ID_FS_LABEL":"Lexar","ID_FS_LABEL_ENC":"Lexar","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"3C7D-0383","ID_FS_UUID_ENC":"3C7D-0383","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SL500","ID_MODEL_ENC":"SL500\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0050","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"4000795312","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"000039ea-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"000039ea","ID_PATH":"platform-xhci-hcd.1-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_1-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1000","ID_SERIAL":"Lexar_SL500_2024R30356000145-0:0","ID_SERIAL_SHORT":"2024R30356000145","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Lexar","ID_VENDOR_ENC":"Lexar\\x20\\x20\\x20","ID_VENDOR_ID":"21c4","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2266","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"18224816"} Sep 09 15:16:34 volumio sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Sep 09 15:16:34 volumio sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:34 volumio sudo[1420]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:34 volumio volumio[798]: umount: /dev/sda1: no mount point specified. Sep 09 15:16:34 volumio volumio[798]: error: Failed to umount Lexar: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda1" Sep 09 15:16:34 volumio volumio[798]: umount: /dev/sda1: no mount point specified. Sep 09 15:16:34 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 09 15:16:35 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Sep 09 15:16:35 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:35 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:35 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:35 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:35 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:36 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:36 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:36 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:36 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:36 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:37 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:37 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:37 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:37 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:37 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:37 volumio sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 15:16:37 volumio sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:37 volumio sudo[1423]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:37 volumio sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 15:16:37 volumio sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:37 volumio sudo[1425]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:37 volumio volumio[798]: verbose: New Socket.io Connection to 192.168.8.5 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 5 Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:38 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:38 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:38 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:38 volumio volumio[798]: info: Listing playlists Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 15:16:38 volumio volumio[798]: info: Received Get System Info Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:16:38 volumio volumio[798]: info: Discovery: Getting this device information Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:38 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:38 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:38 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:38 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:38 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:38 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:39 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:39 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:39 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 09 15:16:39 volumio volumio[798]: info: Received Get System Info Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:16:39 volumio volumio[798]: info: Discovery: Getting this device information Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:39 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:39 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:16:40 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:40 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:40 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:40 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:40 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:40 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/Lexar Sep 09 15:16:40 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:40 volumio sudo[1429]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:40 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/Lexar Sep 09 15:16:40 volumio volumio[798]: umount: /mnt/USB/Lexar: not mounted. Sep 09 15:16:40 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/Lexar"} Sep 09 15:16:41 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:41 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:41 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:41 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:41 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:42 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:42 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:42 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:42 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:42 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:43 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:43 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:43 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:43 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:43 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:44 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:44 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:44 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:44 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:44 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: Sep 09 15:16:45 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand update took 1 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 0 milliseconds Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: 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} Sep 09 15:16:45 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: No code Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: ------------------------------ 62ms Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: Sep 09 15:16:45 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: Sep 09 15:16:45 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: Sep 09 15:16:45 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: 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} Sep 09 15:16:45 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: No code Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: 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} Sep 09 15:16:45 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: No code Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: ------------------------------ 76ms Sep 09 15:16:45 volumio volumio[798]: info: ------------------------------ 75ms Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: Sep 09 15:16:45 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: Sep 09 15:16:45 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 83 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 83 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 8 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 8 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 8 milliseconds Sep 09 15:16:45 volumio volumio[798]: info: sendMpdCommand status took 8 milliseconds Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:16:45 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: 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} Sep 09 15:16:45 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: No code Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: 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} Sep 09 15:16:45 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: No code Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: 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} Sep 09 15:16:45 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: No code Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:16:45 volumio volumio[798]: info: ------------------------------ 167ms Sep 09 15:16:45 volumio volumio[798]: info: ------------------------------ 92ms Sep 09 15:16:45 volumio volumio[798]: info: ------------------------------ 92ms Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:45 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:45 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:45 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:46 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:16:46 volumio volumio[798]: info: CURURI: music-library/USB Sep 09 15:16:46 volumio volumio[798]: info: Preload queue cleared Sep 09 15:16:46 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:46 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:46 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:46 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:46 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:47 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:47 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:47 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:47 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:47 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:47 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:16:47 volumio volumio[798]: info: CURURI: music-library/USB/music Sep 09 15:16:47 volumio volumio[798]: error: Failed LSINFO: null Sep 09 15:16:47 volumio volumio[798]: info: Preload queue cleared Sep 09 15:16:48 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:48 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:48 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:48 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:48 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:49 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:49 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:49 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:49 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:49 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:49 volumio sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/music Sep 09 15:16:49 volumio sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:49 volumio sudo[1445]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:49 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/music Sep 09 15:16:49 volumio volumio[798]: umount: /mnt/USB/music: not mounted. Sep 09 15:16:49 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/music"} Sep 09 15:16:50 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:50 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:50 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:50 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:50 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:51 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:51 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:51 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:51 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:51 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:52 volumio volumio[798]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 15:16:52 volumio volumio[798]: info: Retrying Login Due to Network Error Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:52 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:52 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:52 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:52 volumio sudo[1487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 15:16:52 volumio sudo[1487]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:52 volumio sudo[1487]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:52 volumio sudo[1489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 15:16:52 volumio sudo[1489]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:52 volumio sudo[1489]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:52 volumio volumio[798]: verbose: New Socket.io Connection to 192.168.8.5 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 5 Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:52 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 15:16:52 volumio volumio[798]: info: Received Get System Info Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:16:52 volumio volumio[798]: info: Discovery: Getting this device information Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:52 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:52 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:52 volumio volumio[798]: info: Listing playlists Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 09 15:16:52 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 09 15:16:53 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 09 15:16:53 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:53 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:53 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:53 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:53 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:54 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:54 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:54 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 09 15:16:54 volumio volumio[798]: info: Received Get System Info Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:16:54 volumio volumio[798]: info: Discovery: Getting this device information Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:54 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:54 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:16:55 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:55 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:55 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:55 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:55 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:56 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:56 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:56 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:56 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:56 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:57 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:57 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:57 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:57 volumio sudo[1493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 15:16:57 volumio sudo[1493]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:57 volumio sudo[1493]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:57 volumio sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 15:16:57 volumio sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:16:57 volumio sudo[1495]: pam_unix(sudo:session): session closed for user root Sep 09 15:16:57 volumio volumio[798]: verbose: New Socket.io Connection to 192.168.8.5 from 192.168.8.3 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 5 Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:57 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 15:16:57 volumio volumio[798]: info: Received Get System Info Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:16:57 volumio volumio[798]: info: Discovery: Getting this device information Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:57 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:57 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:57 volumio volumio[798]: info: Listing playlists Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 09 15:16:57 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 09 15:16:58 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:58 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:58 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:58 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:58 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:58 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:58 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:58 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:16:59 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:16:59 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:59 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 09 15:16:59 volumio volumio[798]: info: Received Get System Info Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 09 15:16:59 volumio volumio[798]: info: Discovery: Getting this device information Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:16:59 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:16:59 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 09 15:17:00 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:00 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:00 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:00 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:00 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: info: Sep 09 15:17:01 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand update took 2 milliseconds Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:01 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: 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} Sep 09 15:17:01 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: No code Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: ------------------------------ 47ms Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: info: Sep 09 15:17:01 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: info: Sep 09 15:17:01 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: info: Sep 09 15:17:01 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:17:01 volumio volumio[798]: info: sendMpdCommand status took 1 milliseconds Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:01 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:01 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:01 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: 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} Sep 09 15:17:01 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: No code Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: 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} Sep 09 15:17:01 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:01 volumio volumio[798]: info: No code Sep 09 15:17:01 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:01 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:01 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: ------------------------------ 73ms Sep 09 15:17:02 volumio volumio[798]: info: ------------------------------ 73ms Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:02 volumio volumio[798]: info: Sep 09 15:17:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:02 volumio volumio[798]: info: Sep 09 15:17:02 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:02 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:02 volumio volumio[798]: info: sendMpdCommand status took 84 milliseconds Sep 09 15:17:02 volumio volumio[798]: info: sendMpdCommand status took 84 milliseconds Sep 09 15:17:02 volumio volumio[798]: info: sendMpdCommand status took 12 milliseconds Sep 09 15:17:02 volumio volumio[798]: info: sendMpdCommand status took 12 milliseconds Sep 09 15:17:02 volumio volumio[798]: info: sendMpdCommand status took 11 milliseconds Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:02 volumio volumio[798]: info: Command Router : Notfying DB Updatefalse Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:02 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: 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} Sep 09 15:17:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: No code Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: 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} Sep 09 15:17:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: No code Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: 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} Sep 09 15:17:02 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: No code Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:02 volumio volumio[798]: info: ------------------------------ 167ms Sep 09 15:17:02 volumio volumio[798]: info: ------------------------------ 94ms Sep 09 15:17:02 volumio volumio[798]: info: ------------------------------ 95ms Sep 09 15:17:02 volumio volumio[798]: info: MyVolumio login type: Token Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:02 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:02 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:02 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 15:17:02 volumio volumio[798]: info: CURURI: music-library/USB Sep 09 15:17:02 volumio volumio[798]: info: Preload queue cleared Sep 09 15:17:03 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:03 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:03 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:03 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:03 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:04 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:04 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:04 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:04 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:04 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:04 volumio sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/music Sep 09 15:17:04 volumio sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:17:04 volumio sudo[1512]: pam_unix(sudo:session): session closed for user root Sep 09 15:17:04 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/music Sep 09 15:17:04 volumio volumio[798]: umount: /mnt/USB/music: not mounted. Sep 09 15:17:04 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/music"} Sep 09 15:17:05 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:05 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:05 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:05 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:05 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:06 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:06 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:06 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:06 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:06 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:07 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:07 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:07 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:07 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:07 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:08 volumio sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/USB/Lexar Sep 09 15:17:08 volumio sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:17:08 volumio sudo[1515]: pam_unix(sudo:session): session closed for user root Sep 09 15:17:08 volumio volumio[798]: info: Command failed: /usr/bin/sudo /bin/umount /mnt/USB/Lexar Sep 09 15:17:08 volumio volumio[798]: umount: /mnt/USB/Lexar: not mounted. Sep 09 15:17:08 volumio volumio[798]: {"killed":false,"code":32,"signal":null,"cmd":"/usr/bin/sudo /bin/umount /mnt/USB/Lexar"} Sep 09 15:17:08 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:08 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:08 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:08 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:08 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:09 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:09 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:09 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:09 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:09 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:10 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:10 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:10 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:10 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:10 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:11 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:11 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:11 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:11 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:11 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:12 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:12 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:12 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:12 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:12 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:12 volumio kernel: usb 1-1: new high-speed USB device number 3 using xhci-hcd Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio kernel: usb 2-1: new SuperSpeed USB device number 2 using xhci-hcd Sep 09 15:17:13 volumio kernel: usb 2-1: New USB device found, idVendor=21c4, idProduct=0050, bcdDevice= 1.00 Sep 09 15:17:13 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 09 15:17:13 volumio kernel: usb 2-1: Product: SL500 Sep 09 15:17:13 volumio kernel: usb 2-1: Manufacturer: Lexar Sep 09 15:17:13 volumio kernel: usb 2-1: SerialNumber: 2024R30356000145 Sep 09 15:17:13 volumio kernel: scsi host0: uas Sep 09 15:17:13 volumio kernel: scsi 0:0:0:0: Direct-Access Lexar SL500 1000 PQ: 0 ANSI: 6 Sep 09 15:17:13 volumio kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 0 Sep 09 15:17:13 volumio kernel: sd 0:0:0:0: [sda] 4000797360 512-byte logical blocks: (2.05 TB/1.86 TiB) Sep 09 15:17:13 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Sep 09 15:17:13 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 Sep 09 15:17:13 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 09 15:17:13 volumio kernel: sda: sda1 Sep 09 15:17:13 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Sep 09 15:17:13 volumio volumio[798]: info: Mounting Device Lexar Sep 09 15:17:13 volumio sudo[1530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Lexar -o noatime Sep 09 15:17:13 volumio sudo[1530]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 15:17:13 volumio sudo[1530]: pam_unix(sudo:session): session closed for user root Sep 09 15:17:13 volumio volumio[798]: info: Scanning new location : "USB/Lexar" Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:13 volumio volumio[798]: info: Sep 09 15:17:13 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:13 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:13 volumio volumio[798]: info: Sep 09 15:17:13 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:13 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:13 volumio volumio[798]: info: Sep 09 15:17:13 volumio volumio[798]: ---------------------------- MPD announces state update: update Sep 09 15:17:13 volumio volumio[798]: info: ControllerMpd::getState Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand status Sep 09 15:17:13 volumio volumio[798]: info: sendMpdCommand status took 5 milliseconds Sep 09 15:17:13 volumio volumio[798]: info: sendMpdCommand status took 4 milliseconds Sep 09 15:17:13 volumio volumio[798]: info: sendMpdCommand status took 4 milliseconds Sep 09 15:17:13 volumio volumio[798]: info: sendMpdCommand status took 3 milliseconds Sep 09 15:17:13 volumio volumio[798]: info: sendMpdCommand status took 3 milliseconds Sep 09 15:17:13 volumio volumio[798]: info: sendMpdCommand status took 2 milliseconds Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:13 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:13 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:13 volumio volumio[798]: info: Command Router : Notfying DB Updatetrue Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::Close All Modals sent Sep 09 15:17:13 volumio volumio[798]: verbose: ControllerMpd::parseState Sep 09 15:17:13 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: 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} Sep 09 15:17:13 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: No code Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: 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} Sep 09 15:17:13 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: No code Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: ControllerMpd::pushState Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::servicePushState Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: 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} Sep 09 15:17:13 volumio volumio[798]: verbose: CURRENT POSITION 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::syncState stateService stop Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::syncState currentStatus stop Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: No code Sep 09 15:17:13 volumio volumio[798]: info: CoreStateMachine::pushState Sep 09 15:17:13 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:13 volumio volumio[798]: info: CoreCommandRouter::volumioPushState Sep 09 15:17:13 volumio volumio[798]: info: ------------------------------ 119ms Sep 09 15:17:13 volumio volumio[798]: info: ------------------------------ 118ms Sep 09 15:17:13 volumio volumio[798]: info: ------------------------------ 117ms Sep 09 15:17:14 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:14 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:14 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:14 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:14 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:15 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:15 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:15 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:15 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:15 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:16 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:16 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:16 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:16 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:16 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:17 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:17 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:17 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:17 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:17 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:18 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:18 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:18 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:18 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:18 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:19 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:19 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:19 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:19 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:19 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:20 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:20 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:20 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:20 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:20 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:21 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:21 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:21 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:21 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:21 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:22 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:22 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:22 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:22 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:22 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:23 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:23 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:23 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:23 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:23 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:24 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:24 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:24 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:24 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:24 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:25 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:25 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:25 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:25 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:25 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:26 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:26 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:26 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:26 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:26 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:27 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:27 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:27 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:27 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:27 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:28 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:28 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:28 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:28 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:28 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:29 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:29 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:29 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:29 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:29 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:30 volumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 09 15:17:30 volumio volumio[798]: verbose: ControllerMpd::sendMpdCommand update Sep 09 15:17:30 volumio volumio[798]: info: sendMpdCommand update took 1 milliseconds Sep 09 15:17:30 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:30 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:30 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:30 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:30 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:31 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:31 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:31 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:31 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:31 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:32 volumio volumio[798]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 15:17:32 volumio volumio[798]: info: Retrying Login Due to Network Error Sep 09 15:17:32 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:32 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:32 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:32 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:32 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:33 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:33 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:33 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:33 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:33 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:34 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:34 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:34 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:34 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:34 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:35 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:35 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:35 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:35 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:35 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:36 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:36 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:36 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:36 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:36 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:37 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:37 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:37 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:37 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:37 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:38 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:38 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:38 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:38 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:39 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:39 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:39 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:39 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:39 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:40 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:40 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:40 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:40 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:40 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:41 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:41 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:41 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:41 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:41 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:42 volumio volumio[798]: info: MyVolumio login type: Token Sep 09 15:17:42 volumio volumio[798]: info: CoreCommandRouter::volumioGetQueue Sep 09 15:17:42 volumio volumio[798]: info: CoreStateMachine::getQueue Sep 09 15:17:42 volumio volumio[798]: info: CorePlayQueue::getQueue Sep 09 15:17:42 volumio volumio[798]: info: CoreCommandRouter::volumioGetState Sep 09 15:17:42 volumio volumio[798]: info: CorePlayQueue::getTrack 155 Sep 09 15:17:43 volumio volumio[798]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 15:17:43 volumio volumio[798]: Error: connect ETIMEDOUT 88.191.249.183:443 Sep 09 15:17:43 volumio volumio[798]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 09 15:17:43 volumio volumio[798]: errno: -110, Sep 09 15:17:43 volumio volumio[798]: code: 'ETIMEDOUT', Sep 09 15:17:43 volumio volumio[798]: syscall: 'connect', Sep 09 15:17:43 volumio volumio[798]: address: '88.191.249.183', Sep 09 15:17:43 volumio volumio[798]: port: 443 Sep 09 15:17:43 volumio volumio[798]: } Sep 09 15:17:43 volumio volumio[798]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 15:17:43 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-09 15:16 Sep 09 15:17:43 volumio sudo[1553]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"