-- Logs begin at Thu 2024-11-28 15:18:11 CST, end at Thu 2024-11-28 15:26:48 CST. -- Nov 28 15:25:00 volumio volumio[979]: info: Command Router : Notfying DB Updatetrue Nov 28 15:25:00 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:00 volumio volumio[979]: info: Command Router : Notfying DB Updatetrue Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:00 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:00 volumio volumio[979]: info: Command Router : Notfying DB Updatetrue Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:00 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:00 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: 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} Nov 28 15:25:00 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: No code Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: 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} Nov 28 15:25:00 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: No code Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: 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} Nov 28 15:25:00 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: No code Nov 28 15:25:00 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:00 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:00 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:00 volumio volumio[979]: info: ------------------------------ 482ms Nov 28 15:25:00 volumio volumio[979]: info: ------------------------------ 478ms Nov 28 15:25:00 volumio volumio[979]: info: ------------------------------ 478ms Nov 28 15:25:02 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 15:25:06 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 15:25:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 28 15:25:07 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand update Nov 28 15:25:07 volumio volumio[979]: info: sendMpdCommand update took 4 milliseconds Nov 28 15:25:10 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 15:25:14 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 15:25:18 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 15:25:43 volumio volumio[979]: info: MPD Database updated - AlbumList cache refreshed Nov 28 15:25:43 volumio volumio[979]: info: Nov 28 15:25:43 volumio volumio[979]: ---------------------------- MPD announces state update: database Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: Nov 28 15:25:43 volumio volumio[979]: ---------------------------- MPD announces state update: update Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: MPD Database updated - AlbumList cache refreshed Nov 28 15:25:43 volumio volumio[979]: info: Nov 28 15:25:43 volumio volumio[979]: ---------------------------- MPD announces state update: database Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: Nov 28 15:25:43 volumio volumio[979]: ---------------------------- MPD announces state update: update Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: MPD Database updated - AlbumList cache refreshed Nov 28 15:25:43 volumio volumio[979]: info: Nov 28 15:25:43 volumio volumio[979]: ---------------------------- MPD announces state update: database Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: Nov 28 15:25:43 volumio volumio[979]: ---------------------------- MPD announces state update: update Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:43 volumio volumio[979]: info: sendMpdCommand status took 540 milliseconds Nov 28 15:25:43 volumio volumio[979]: info: sendMpdCommand status took 539 milliseconds Nov 28 15:25:43 volumio volumio[979]: info: sendMpdCommand status took 537 milliseconds Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:43 volumio volumio[979]: info: Command Router : Notfying DB Updatetrue Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:43 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:43 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:43 volumio volumio[979]: 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} Nov 28 15:25:43 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:43 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:43 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:43 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:43 volumio volumio[979]: info: No code Nov 28 15:25:43 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:43 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:43 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:43 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:43 volumio volumio[979]: 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} Nov 28 15:25:43 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ------------------------------ 734ms Nov 28 15:25:44 volumio volumio[979]: info: ------------------------------ 736ms Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 975 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 975 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 974 milliseconds Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: Command Router : Notfying DB Updatetrue Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ------------------------------ 1096ms Nov 28 15:25:44 volumio volumio[979]: info: ------------------------------ 1096ms Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 1290 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 1296 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 1297 milliseconds Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: Command Router : Notfying DB Updatetrue Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ------------------------------ 1439ms Nov 28 15:25:44 volumio volumio[979]: info: ------------------------------ 1441ms Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:44 volumio volumio[979]: info: Nov 28 15:25:44 volumio volumio[979]: ---------------------------- MPD announces state update: update Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:44 volumio volumio[979]: info: Nov 28 15:25:44 volumio volumio[979]: ---------------------------- MPD announces state update: update Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:44 volumio volumio[979]: info: Nov 28 15:25:44 volumio volumio[979]: ---------------------------- MPD announces state update: update Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::getState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::sendMpdCommand status Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 22 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 19 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 19 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 18 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 17 milliseconds Nov 28 15:25:44 volumio volumio[979]: info: sendMpdCommand status took 16 milliseconds Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: Command Router : Notfying DB Updatefalse Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: Command Router : Notfying DB Updatefalse Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: Command Router : Notfying DB Updatefalse Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::Close All Modals sent Nov 28 15:25:44 volumio volumio[979]: verbose: ControllerMpd::parseState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: ControllerMpd::pushState Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::servicePushState Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: 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} Nov 28 15:25:44 volumio volumio[979]: verbose: CURRENT POSITION 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState stateService stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::syncState currentStatus stop Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:44 volumio volumio[979]: info: No code Nov 28 15:25:44 volumio volumio[979]: info: CoreStateMachine::pushState Nov 28 15:25:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:25:44 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Nov 28 15:25:45 volumio volumio[979]: info: ------------------------------ 273ms Nov 28 15:25:45 volumio volumio[979]: info: ------------------------------ 270ms Nov 28 15:25:45 volumio volumio[979]: info: ------------------------------ 268ms Nov 28 15:25:49 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 28 15:25:49 volumio volumio[979]: info: CURURI: music-library Nov 28 15:25:49 volumio volumio[979]: info: Preload queue cleared Nov 28 15:25:55 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 28 15:25:55 volumio volumio[979]: info: CURURI: music-library/INTERNAL Nov 28 15:25:55 volumio volumio[979]: error: Failed LSINFO: null Nov 28 15:25:55 volumio volumio[979]: info: Preload queue cleared Nov 28 15:25:58 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 28 15:25:58 volumio volumio[979]: info: CURURI: music-library Nov 28 15:25:58 volumio volumio[979]: info: Preload queue cleared Nov 28 15:26:35 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 15:26:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 15:26:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 15:26:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 28 15:26:36 volumio volumio[979]: info: Received Get System Version Nov 28 15:26:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 15:26:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Nov 28 15:26:42 volumio volumio[979]: info: CoreCommandRouter::Reload Ui Nov 28 15:26:43 volumio sudo[3232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 15:26:43 volumio sudo[3232]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:43 volumio sudo[3234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 15:26:43 volumio sudo[3234]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:43 volumio sudo[3232]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:43 volumio sudo[3234]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:43 volumio volumio[979]: verbose: New Socket.io Connection to 192.168.0.254 from 192.168.0.100 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/27.1 Chrome/125.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 28 15:26:43 volumio wpa_supplicant[905]: TDLS: Creating peer entry for 22:c8:f4:d5:e2:91 Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::volumioGetVisibleSources Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 28 15:26:43 volumio volumio[979]: info: Received Get System Info Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 15:26:43 volumio volumio[979]: info: Discovery: Getting this device information Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Nov 28 15:26:43 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 15:26:43 volumio volumio-remote-updater[2911]: No test mode Nov 28 15:26:43 volumio volumio-remote-updater[2911]: No alpha test mode Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:43 volumio volumio[979]: info: Retrieving Cloud Streaming UI Nov 28 15:26:43 volumio volumio[979]: info: Getting Tidal Cloud Configuration Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:43 volumio volumio[979]: info: Getting Qobuz Cloud Configuration Nov 28 15:26:43 volumio volumio[979]: info: Asking plugin for UI Config Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:43 volumio volumio[979]: info: Getting Spotify Cloud Configuration Nov 28 15:26:43 volumio volumio[979]: info: Asking plugin for UI Config Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:43 volumio volumio[979]: info: Saving Spotify Acccount Nov 28 15:26:43 volumio volumio[979]: info: Got Tidal Cloud Configuration Nov 28 15:26:43 volumio volumio[979]: info: Got it Nov 28 15:26:43 volumio volumio[979]: info: Got it Nov 28 15:26:43 volumio volumio[979]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 28 15:26:43 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:43 volumio volumio[979]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 28 15:26:44 volumio volumio[979]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 28 15:26:44 volumio wpa_supplicant[905]: TDLS: Dialog Token in TPK M1 52 Nov 28 15:26:44 volumio wpa_supplicant[905]: nl80211: kernel reports: key addition failed Nov 28 15:26:44 volumio wpa_supplicant[905]: TDLS: Failed to set TPK to the driver Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::volumioGetVisibleSources Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 28 15:26:44 volumio volumio[979]: info: Received Get System Info Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 15:26:44 volumio volumio[979]: info: Discovery: Getting this device information Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Nov 28 15:26:44 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 28 15:26:44 volumio volumio[979]: info: Loading i18n strings for locale zh Nov 28 15:26:44 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 28 15:26:44 volumio volumio[979]: info: Setting timezone to Asia/Shanghai Nov 28 15:26:44 volumio sudo[3248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 28 15:26:44 volumio sudo[3248]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:44 volumio sudo[3248]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:44 volumio sudo[3251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Nov 28 15:26:44 volumio sudo[3251]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:44 volumio sudo[3251]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:45 volumio sudo[3268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 28 15:26:45 volumio sudo[3268]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:45 volumio sudo[3268]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:45 volumio sudo[3271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Nov 28 15:26:45 volumio sudo[3271]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:45 volumio dbus-daemon[638]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.23' (uid=0 pid=3272 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai ") Nov 28 15:26:45 volumio systemd[1]: Starting Time & Date Service... Nov 28 15:26:45 volumio dbus-daemon[638]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 28 15:26:45 volumio systemd[1]: Started Time & Date Service. Nov 28 15:26:45 volumio sudo[3271]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:45 volumio volumio[979]: info: Fetching Streaming Services browse cache Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 15:26:45 volumio volumio[979]: Updating browse sources language Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:45 volumio volumio[979]: info: Retrieving Cloud Streaming UI Nov 28 15:26:45 volumio volumio[979]: info: Getting Tidal Cloud Configuration Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:45 volumio volumio[979]: info: Getting Qobuz Cloud Configuration Nov 28 15:26:45 volumio volumio[979]: info: Asking plugin for UI Config Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:45 volumio volumio[979]: info: Getting Spotify Cloud Configuration Nov 28 15:26:45 volumio volumio[979]: info: Asking plugin for UI Config Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:45 volumio volumio[979]: info: Saving Spotify Acccount Nov 28 15:26:45 volumio volumio[979]: info: Got Tidal Cloud Configuration Nov 28 15:26:45 volumio volumio[979]: info: Got it Nov 28 15:26:45 volumio volumio[979]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 15:26:45 volumio volumio[979]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 28 15:26:45 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 15:26:46 volumio volumio-remote-updater[2911]: No test mode Nov 28 15:26:46 volumio volumio-remote-updater[2911]: No alpha test mode Nov 28 15:26:46 volumio volumio[979]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 28 15:26:46 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 28 15:26:46 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 28 15:26:46 volumio volumio[979]: info: Loading i18n strings for locale en Nov 28 15:26:46 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 28 15:26:46 volumio volumio[979]: info: Setting timezone to Africa/Abidjan Nov 28 15:26:46 volumio sudo[3276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 28 15:26:46 volumio sudo[3276]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:46 volumio sudo[3276]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:46 volumio sudo[3279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Africa/Abidjan /etc/localtime Nov 28 15:26:46 volumio sudo[3279]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:46 volumio sudo[3279]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:46 volumio sudo[3282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 28 15:26:46 volumio sudo[3282]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:46 volumio sudo[3282]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:46 volumio sudo[3285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Africa/Abidjan Nov 28 15:26:46 volumio sudo[3285]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:46 volumio systemd-timedated[3273]: Failed to set time zone: Permission denied Nov 28 15:26:46 volumio sudo[3285]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:46 volumio volumio[979]: Failed to set time zone: Access denied Nov 28 15:26:46 volumio volumio[979]: info: Could not set timezone, retrying Nov 28 15:26:46 volumio volumio[979]: Updating browse sources language Nov 28 15:26:46 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 15:26:46 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 28 15:26:46 volumio volumio[979]: info: Loading i18n strings for locale zh Nov 28 15:26:47 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 28 15:26:47 volumio volumio[979]: info: Setting timezone to Asia/Shanghai Nov 28 15:26:47 volumio sudo[3288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 28 15:26:47 volumio sudo[3288]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:47 volumio sudo[3288]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:47 volumio sudo[3291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Nov 28 15:26:47 volumio sudo[3291]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:47 volumio sudo[3291]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:47 volumio sudo[3294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 28 15:26:47 volumio sudo[3294]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:47 volumio sudo[3294]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:47 volumio sudo[3297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Nov 28 15:26:47 volumio sudo[3297]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:47 volumio systemd-timedated[3273]: Failed to set time zone: Permission denied Nov 28 15:26:47 volumio sudo[3297]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:47 volumio volumio[979]: Failed to set time zone: Access denied Nov 28 15:26:47 volumio volumio[979]: info: Could not set timezone, retrying Nov 28 15:26:47 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 28 15:26:47 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 28 15:26:47 volumio volumio[979]: info: Fetching Streaming Services browse cache Nov 28 15:26:47 volumio sudo[3300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 28 15:26:47 volumio sudo[3300]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:47 volumio volumio[979]: Updating browse sources language Nov 28 15:26:47 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 15:26:47 volumio volumio[979]: info: Fetching Streaming Services browse cache Nov 28 15:26:47 volumio sudo[3303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Africa/Abidjan Nov 28 15:26:47 volumio sudo[3303]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 15:26:47 volumio systemd-timedated[3273]: Failed to set time zone: Permission denied Nov 28 15:26:47 volumio sudo[3303]: pam_unix(sudo:session): session closed for user root Nov 28 15:26:47 volumio volumio[979]: Failed to set time zone: Access denied Nov 28 15:26:47 volumio volumio[979]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 15:26:48 volumio volumio[979]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Africa/Abidjan' Nov 28 15:26:48 volumio volumio[979]: Failed to set time zone: Access denied Nov 28 15:26:48 volumio volumio[979]: at checkExecSyncError (child_process.js:790:11) Nov 28 15:26:48 volumio volumio[979]: at execSync (child_process.js:863:15) Nov 28 15:26:48 volumio volumio[979]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Nov 28 15:26:48 volumio volumio[979]: at listOnTimeout (internal/timers.js:557:17) Nov 28 15:26:48 volumio volumio[979]: at processTimers (internal/timers.js:500:7) { Nov 28 15:26:48 volumio volumio[979]: status: 1, Nov 28 15:26:48 volumio volumio[979]: signal: null, Nov 28 15:26:48 volumio volumio[979]: output: [ null, '', 'Failed to set time zone: Access denied\n' ], Nov 28 15:26:48 volumio volumio[979]: pid: 3302, Nov 28 15:26:48 volumio volumio[979]: stdout: '', Nov 28 15:26:48 volumio volumio[979]: stderr: 'Failed to set time zone: Access denied\n' Nov 28 15:26:48 volumio volumio[979]: } Nov 28 15:26:48 volumio volumio[979]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 15:26:48 volumio sudo[3316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 15:25 Nov 28 15:26:48 volumio sudo[3316]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"