-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Tue 2025-06-03 06:04:33 +07. -- Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand rescan Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand rescan took 3 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 1 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 1 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatetrue Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: No code Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: ------------------------------ 61ms Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 8 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 6 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 5 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 5 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 2 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 1 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatetrue Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatetrue Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatetrue Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: No code Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: No code Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: No code Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:00 volumio-bm volumio[1006]: info: ------------------------------ 131ms Jun 03 06:03:00 volumio-bm volumio[1006]: info: ------------------------------ 128ms Jun 03 06:03:00 volumio-bm volumio[1006]: info: ------------------------------ 126ms Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: Jun 03 06:03:00 volumio-bm volumio[1006]: ---------------------------- MPD announces state update: update Jun 03 06:03:00 volumio-bm volumio[1006]: info: ControllerMpd::getState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::sendMpdCommand status Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 4 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 4 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 3 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 3 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 2 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 2 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 1 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: info: sendMpdCommand status took 2 milliseconds Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatefalse Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatefalse Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatefalse Jun 03 06:03:00 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:00 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:01 volumio-bm volumio[1006]: info: Command Router : Notfying DB Updatefalse Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::Close All Modals sent Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: ControllerMpd::parseState Jun 03 06:03:01 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: No code Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: No code Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: No code Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: ControllerMpd::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::servicePushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 06:03:01 volumio-bm volumio[1006]: verbose: CURRENT POSITION 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState stateService stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::syncState currentStatus stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: No code Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreStateMachine::pushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:01 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioPushState Jun 03 06:03:01 volumio-bm volumio[1006]: info: ------------------------------ 153ms Jun 03 06:03:01 volumio-bm volumio[1006]: info: ------------------------------ 153ms Jun 03 06:03:01 volumio-bm volumio[1006]: info: ------------------------------ 152ms Jun 03 06:03:01 volumio-bm volumio[1006]: info: ------------------------------ 152ms Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:01 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:03:02 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 06:03:05 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:05 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:05 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:03:05 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:03:06 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 06:03:10 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 06:03:14 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 06:03:15 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:15 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:16 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:16 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:18 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetQueue Jun 03 06:03:18 volumio-bm volumio[1006]: info: CoreStateMachine::getQueue Jun 03 06:03:18 volumio-bm volumio[1006]: info: CorePlayQueue::getQueue Jun 03 06:03:25 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:25 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:25 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:03:25 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:03:28 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:28 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:34 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:03:34 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 03 06:03:34 volumio-bm volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 06:03:35 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:35 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:43 volumio-bm volumio[1006]: info: Starting Uninstall of plugin system_controller - ampswitch Jun 03 06:03:43 volumio-bm volumio[1006]: info: Uninstalling plugin ampswitch Jun 03 06:03:43 volumio-bm volumio[1006]: info: [ASDebug] Port: 24 Jun 03 06:03:43 volumio-bm volumio[1006]: info: [ASDebug] Inverted: false Jun 03 06:03:43 volumio-bm volumio[1006]: info: [ASDebug] Delay: 720 Jun 03 06:03:45 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:45 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:45 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:03:45 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:03:50 volumio-bm volumio[1006]: info: Starting Uninstall of plugin user_interface - Systeminfo Jun 03 06:03:50 volumio-bm volumio[1006]: info: Uninstalling plugin Systeminfo Jun 03 06:03:50 volumio-bm volumio[1006]: info: Disabling plugin Systeminfo Jun 03 06:03:50 volumio-bm volumio[1006]: info: Checking if uninstall.sh is present Jun 03 06:03:50 volumio-bm volumio[1006]: info: Executing uninstall.sh Jun 03 06:03:50 volumio-bm sudo[6597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/Systeminfo/uninstall.sh Jun 03 06:03:50 volumio-bm sudo[6597]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 06:03:50 volumio-bm sudo[6600]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/playonconnect.* Jun 03 06:03:50 volumio-bm sudo[6600]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 06:03:50 volumio-bm sudo[6600]: pam_unix(sudo:session): session closed for user root Jun 03 06:03:50 volumio-bm sudo[6597]: pam_unix(sudo:session): session closed for user root Jun 03 06:03:50 volumio-bm volumio[1006]: info: Uninstall script completed Jun 03 06:03:50 volumio-bm volumio[1006]: info: Removing plugin Systeminfo from configuration Jun 03 06:03:50 volumio-bm volumio[1006]: info: Successfully removed Systeminfo configuration files Jun 03 06:03:50 volumio-bm volumio[1006]: info: Plugin folders cleanup Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning into folder /volumio/app/plugins/ Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category audio_interface Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category miscellanea Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category music_service Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category plugins.json Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category system_controller Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category user_interface Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning into folder /data/plugins/ Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category audio_interface Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category system_controller Jun 03 06:03:50 volumio-bm volumio[1006]: info: Scanning category user_interface Jun 03 06:03:50 volumio-bm volumio[1006]: info: Cleaning folder for Systeminfo Jun 03 06:03:50 volumio-bm volumio[1006]: info: Plugin folders cleanup completed Jun 03 06:03:50 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:03:50 volumio-bm volumio[1006]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.54","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false}] Jun 03 06:03:50 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 03 06:03:50 volumio-bm volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 06:03:53 volumio-bm ntpd[763]: Soliciting pool server 2400:e920:0:5::14 Jun 03 06:03:55 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:03:55 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:03:57 volumio-bm volumio[1006]: info: Starting Uninstall of plugin system_controller - ampswitch Jun 03 06:03:57 volumio-bm volumio[1006]: info: Uninstalling plugin ampswitch Jun 03 06:03:57 volumio-bm volumio[1006]: info: [ASDebug] Port: 24 Jun 03 06:03:57 volumio-bm volumio[1006]: info: [ASDebug] Inverted: false Jun 03 06:03:57 volumio-bm volumio[1006]: info: [ASDebug] Delay: 720 Jun 03 06:04:01 volumio-bm volumio[1006]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 06:04:01 volumio-bm volumio[1006]: info: [ASDebug] Setting UI defaults Jun 03 06:04:01 volumio-bm volumio[1006]: info: [ASDebug] Port: 24 Jun 03 06:04:01 volumio-bm volumio[1006]: info: [ASDebug] Inverted: false Jun 03 06:04:01 volumio-bm volumio[1006]: info: [ASDebug] Latched: false Jun 03 06:04:01 volumio-bm volumio[1006]: info: [ASDebug] On pulse width: 500 Jun 03 06:04:01 volumio-bm volumio[1006]: info: [ASDebug] Off pulse width: 500 Jun 03 06:04:05 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:04:05 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:04:05 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:04:05 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:04:09 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:04:09 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:04:14 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:04:14 volumio-bm volumio[1006]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 03 06:04:15 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:04:15 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:04:19 volumio-bm volumio[1006]: info: Enabling plugin ampswitch Jun 03 06:04:19 volumio-bm volumio[1006]: info: Loading plugin "ampswitch"... Jun 03 06:04:19 volumio-bm volumio[1006]: info: Applying required configuration parameters for plugin ampswitch Jun 03 06:04:19 volumio-bm volumio[1006]: info: PLUGIN START: ampswitch Jun 03 06:04:19 volumio-bm volumio[1006]: info: Done. Jun 03 06:04:19 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:04:19 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:04:19 volumio-bm volumio[1006]: info: [ASDebug] CurState: stop PrevState: stop Jun 03 06:04:23 volumio-bm volumio[1006]: info: Starting Uninstall of plugin system_controller - ampswitch Jun 03 06:04:23 volumio-bm volumio[1006]: info: Uninstalling plugin ampswitch Jun 03 06:04:23 volumio-bm volumio[1006]: info: [ASDebug] Port: 24 Jun 03 06:04:23 volumio-bm volumio[1006]: info: [ASDebug] Inverted: false Jun 03 06:04:23 volumio-bm volumio[1006]: info: [ASDebug] Delay: 720 Jun 03 06:04:25 volumio-bm volumio[1006]: info: CoreCommandRouter::volumioGetState Jun 03 06:04:25 volumio-bm volumio[1006]: info: CorePlayQueue::getTrack 0 Jun 03 06:04:25 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:04:25 volumio-bm volumio[1006]: info: Listing playlists Jun 03 06:04:28 volumio-bm volumio[1006]: info: [ASDebug] Port: 24 Jun 03 06:04:28 volumio-bm volumio[1006]: info: [ASDebug] Inverted: false Jun 03 06:04:28 volumio-bm volumio[1006]: info: [ASDebug] Delay: 720 Jun 03 06:04:33 volumio-bm volumio[1006]: info: Starting Uninstall of plugin system_controller - ampswitch Jun 03 06:04:33 volumio-bm volumio[1006]: info: Uninstalling plugin ampswitch Jun 03 06:04:33 volumio-bm volumio[1006]: info: [ASDebug] Port: 24 Jun 03 06:04:33 volumio-bm volumio[1006]: info: [ASDebug] Inverted: false Jun 03 06:04:33 volumio-bm volumio[1006]: info: [ASDebug] Delay: 720 Jun 03 06:04:33 volumio-bm volumio[1006]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 06:04:33 volumio-bm volumio[1006]: Error: EBADF: bad file descriptor, close Jun 03 06:04:33 volumio-bm volumio[1006]: at Object.closeSync (fs.js:439:3) Jun 03 06:04:33 volumio-bm volumio[1006]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Jun 03 06:04:33 volumio-bm volumio[1006]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Jun 03 06:04:33 volumio-bm volumio[1006]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Jun 03 06:04:33 volumio-bm volumio[1006]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Jun 03 06:04:33 volumio-bm volumio[1006]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Jun 03 06:04:33 volumio-bm volumio[1006]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 03 06:04:33 volumio-bm volumio[1006]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Jun 03 06:04:33 volumio-bm volumio[1006]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) Jun 03 06:04:33 volumio-bm volumio[1006]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1260:45) Jun 03 06:04:33 volumio-bm volumio[1006]: at Socket.emit (events.js:315:20) Jun 03 06:04:33 volumio-bm volumio[1006]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 03 06:04:33 volumio-bm volumio[1006]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jun 03 06:04:33 volumio-bm volumio[1006]: errno: -9, Jun 03 06:04:33 volumio-bm volumio[1006]: syscall: 'close', Jun 03 06:04:33 volumio-bm volumio[1006]: code: 'EBADF' Jun 03 06:04:33 volumio-bm volumio[1006]: } Jun 03 06:04:33 volumio-bm volumio[1006]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 06:04:33 volumio-bm sudo[6732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-03 06:03 Jun 03 06:04:33 volumio-bm sudo[6732]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"