-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2024-09-03 15:57:39 CST. -- Sep 03 15:56:00 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:03 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:04 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand update Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: Sep 03 15:56:04 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand update took 7 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: Sep 03 15:56:04 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:04 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: Sep 03 15:56:04 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:04 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: Sep 03 15:56:04 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:04 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 16 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 14 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 13 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 11 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 10 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 9 milliseconds Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:04 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:04 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:04 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: Sep 03 15:56:04 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:04 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: Sep 03 15:56:04 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:04 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 185 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 183 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 129 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 88 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 47 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 15 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 13 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 11 milliseconds Sep 03 15:56:04 volumio volumio[1909]: info: sendMpdCommand status took 10 milliseconds Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:04 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:04 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:04 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:05 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:05 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:05 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:05 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:05 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:05 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: No code Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:05 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:05 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: No code Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:05 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:05 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: No code Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: ------------------------------ 526ms Sep 03 15:56:05 volumio volumio[1909]: info: ------------------------------ 524ms Sep 03 15:56:05 volumio volumio[1909]: info: ------------------------------ 522ms Sep 03 15:56:05 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 409 milliseconds Sep 03 15:56:05 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 368 milliseconds Sep 03 15:56:05 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 327 milliseconds Sep 03 15:56:05 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:05 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:05 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:05 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:05 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:05 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: No code Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:05 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:05 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: No code Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:05 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:05 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: No code Sep 03 15:56:05 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:05 volumio volumio[1909]: info: ------------------------------ 838ms Sep 03 15:56:05 volumio volumio[1909]: info: ------------------------------ 667ms Sep 03 15:56:05 volumio volumio[1909]: info: ------------------------------ 665ms Sep 03 15:56:05 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand rescan Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: Sep 03 15:56:06 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand rescan took 7 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: Sep 03 15:56:06 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: Sep 03 15:56:06 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: Sep 03 15:56:06 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 15 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 13 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 11 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 10 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 9 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 8 milliseconds Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: Sep 03 15:56:06 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: Sep 03 15:56:06 volumio volumio[1909]: ---------------------------- MPD announces state update: update Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::getState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand status Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 179 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 177 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 124 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 83 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 42 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 14 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 10 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 10 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand status took 9 milliseconds Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: info: Command Router : Notfying DB Updatefalse Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::Close All Modals sent Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseState Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:06 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:06 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: No code Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:06 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:06 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: No code Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:06 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:06 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: No code Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: ------------------------------ 516ms Sep 03 15:56:06 volumio volumio[1909]: info: ------------------------------ 514ms Sep 03 15:56:06 volumio volumio[1909]: info: ------------------------------ 513ms Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 355 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 312 milliseconds Sep 03 15:56:06 volumio volumio[1909]: info: sendMpdCommand playlistinfo took 266 milliseconds Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:06 volumio volumio[1909]: verbose: ControllerMpd::parseTrackInfo Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:06 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:06 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: No code Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:06 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:06 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: No code Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: ControllerMpd::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::servicePushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: CorePlayQueue::getTrack 0 Sep 03 15:56:06 volumio volumio[1909]: verbose: STATE SERVICE {"status":"stop","position":2,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"knetterwous7","artist":"Knetterwous7","album":null,"uri":"http://listen.shoutcast.com/knetterwous7","trackType":""} Sep 03 15:56:06 volumio volumio[1909]: verbose: CURRENT POSITION 0 Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState stateService stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::syncState currentStatus stop Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: No code Sep 03 15:56:06 volumio volumio[1909]: info: CoreStateMachine::pushState Sep 03 15:56:06 volumio volumio[1909]: info: CoreCommandRouter::volumioPushState Sep 03 15:56:06 volumio volumio[1909]: info: ------------------------------ 744ms Sep 03 15:56:06 volumio volumio[1909]: info: ------------------------------ 579ms Sep 03 15:56:06 volumio volumio[1909]: info: ------------------------------ 579ms Sep 03 15:56:07 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:11 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:15 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:19 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:23 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:27 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:31 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:35 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:39 volumio volumio[1909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 03 15:56:45 volumio kernel: hwmon hwmon1: Voltage normalised Sep 03 15:56:47 volumio kernel: hwmon hwmon1: Undervoltage detected! Sep 03 15:56:55 volumio kernel: hwmon hwmon1: Voltage normalised Sep 03 15:56:58 volumio kernel: hwmon hwmon1: Undervoltage detected! Sep 03 15:57:00 volumio volumio[1909]: info: Preload queue cleared Sep 03 15:57:12 volumio kernel: hwmon hwmon1: Voltage normalised Sep 03 15:57:31 volumio kernel: hwmon hwmon1: Undervoltage detected! Sep 03 15:57:38 volumio volumio[1909]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 03 15:57:38 volumio volumio[1909]: Error: connect ETIMEDOUT 118.193.202.219:80 Sep 03 15:57:38 volumio volumio[1909]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 03 15:57:38 volumio volumio[1909]: errno: -110, Sep 03 15:57:38 volumio volumio[1909]: code: 'ETIMEDOUT', Sep 03 15:57:38 volumio volumio[1909]: syscall: 'connect', Sep 03 15:57:38 volumio volumio[1909]: address: '118.193.202.219', Sep 03 15:57:38 volumio volumio[1909]: port: 80 Sep 03 15:57:38 volumio volumio[1909]: } Sep 03 15:57:38 volumio volumio[1909]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 03 15:57:39 volumio sudo[2195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-03 15:56 Sep 03 15:57:39 volumio sudo[2195]: 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="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"