-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-09-04 15:32:11 CST. -- Sep 04 15:31:03 volumio volumio[974]: info: Preload queue cleared Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::ClearQueue Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::stop Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::stPlaybackTimer Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::updateTrackBlock Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrackBlock Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 1 Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::serviceStop Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 1 Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::serviceStop Sep 04 15:31:03 volumio volumio[974]: info: ControllerMpd::stop Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::clearPlayQueue Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::saveQueue Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioPushQueue Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::addQueueItems Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::addQueueItems Sep 04 15:31:03 volumio volumio[974]: info: Preload queue cleared Sep 04 15:31:03 volumio volumio[974]: info: Adding Item to queue: http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8 Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioPushQueue Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::saveQueue Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::updateTrackBlock Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrackBlock Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioPlay Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::play index 0 Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::stop Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::play index undefined Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::startPlaybackTimer Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:03 volumio volumio[974]: info: [1756971063724] ControllerWebradio::clearAddPlayTrack Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand stop took 27 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand stop took 6 milliseconds Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:03 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:03 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:03 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand status took 7 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand clear took 6 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand status took 4 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand status took 3 milliseconds Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand add "http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8" Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:03 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:03 volumio volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 15:31:03 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:03 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:03 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:03 volumio volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 30ms Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 30ms Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:03 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:03 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:03 volumio volumio[974]: error: updateQueue error: null Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:03 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 34ms Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand add "http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8" took 31 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 6ms Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 5ms Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:03 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 15:31:03 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand play Sep 04 15:31:03 volumio volumio[974]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 45ms Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:03 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:03 volumio volumio[974]: info: Sep 04 15:31:03 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:03 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 17ms Sep 04 15:31:03 volumio volumio[974]: info: sendMpdCommand play took 13 milliseconds Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 11ms Sep 04 15:31:03 volumio volumio[974]: info: ------------------------------ 10ms Sep 04 15:31:05 volumio volumio[974]: info: Sep 04 15:31:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:05 volumio volumio[974]: info: Sep 04 15:31:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:05 volumio volumio[974]: info: Sep 04 15:31:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:05 volumio volumio[974]: info: Sep 04 15:31:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand status took 10 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand status took 8 milliseconds Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:05 volumio volumio[974]: info: Sep 04 15:31:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:05 volumio volumio[974]: info: Sep 04 15:31:05 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand status took 14 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand status took 11 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand status took 10 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand status took 9 milliseconds Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:05 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus stop Sep 04 15:31:05 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:05 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:05 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:05 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:05 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:05 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:05 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:05 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:05 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:05 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:05 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:05 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:05 volumio volumio[974]: info: ------------------------------ 56ms Sep 04 15:31:05 volumio volumio[974]: info: ------------------------------ 73ms Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 47 milliseconds Sep 04 15:31:05 volumio volumio[974]: info: sendMpdCommand playlistinfo took 48 milliseconds Sep 04 15:31:06 volumio volumio[974]: info: sendMpdCommand playlistinfo took 45 milliseconds Sep 04 15:31:06 volumio volumio[974]: info: sendMpdCommand playlistinfo took 46 milliseconds Sep 04 15:31:06 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:06 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:06 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:06 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:06 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:06 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:06 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:06 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:06 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:06 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:06 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:06 volumio volumio[974]: info: ------------------------------ 180ms Sep 04 15:31:06 volumio volumio[974]: info: ------------------------------ 177ms Sep 04 15:31:06 volumio volumio[974]: info: ------------------------------ 172ms Sep 04 15:31:06 volumio volumio[974]: info: ------------------------------ 170ms Sep 04 15:31:08 volumio volumio[974]: info: VolumeController::SetAlsaVolume49 Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: Sep 04 15:31:08 volumio volumio[974]: ---------------------------- MPD announces state update: mixer Sep 04 15:31:08 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:08 volumio volumio[974]: info: Sep 04 15:31:08 volumio volumio[974]: ---------------------------- MPD announces state update: mixer Sep 04 15:31:08 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:08 volumio volumio[974]: info: Sep 04 15:31:08 volumio volumio[974]: ---------------------------- MPD announces state update: mixer Sep 04 15:31:08 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:08 volumio volumio[974]: info: sendMpdCommand status took 9 milliseconds Sep 04 15:31:08 volumio volumio[974]: info: sendMpdCommand status took 6 milliseconds Sep 04 15:31:08 volumio volumio[974]: info: sendMpdCommand status took 4 milliseconds Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:08 volumio volumio[974]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 04 15:31:08 volumio volumio[974]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 04 15:31:08 volumio volumio[974]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:08 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:08 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:08 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:08 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3736,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:08 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:08 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:08 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:08 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3862,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:08 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:08 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:08 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:08 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3862,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:08 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:08 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:08 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:08 volumio volumio[974]: info: ------------------------------ 96ms Sep 04 15:31:08 volumio volumio[974]: info: ------------------------------ 95ms Sep 04 15:31:08 volumio volumio[974]: info: ------------------------------ 92ms Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 15:31:11 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 15:31:15 volumio volumio[974]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 04 15:31:15 volumio volumio[974]: info: Preparing to save Alsa Options, stopping services first Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioGetState Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioStop Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::stop Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::stPlaybackTimer Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::updateTrackBlock Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrackBlock Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::serviceStop Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::serviceStop Sep 04 15:31:15 volumio volumio[974]: info: [1756971075459] ControllerWebradio::stop Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 15:31:15 volumio volumio[974]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphones"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 15:31:15 volumio volumio[974]: info: Found match in Cards Database: setting mixer PCM for card Headphones Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 15:31:15 volumio volumio[974]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 04 15:31:15 volumio volumio[974]: info: Disabling external Volume Control Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 15:31:15 volumio volumio[974]: info: Preparing to generate the ALSA configuration file Sep 04 15:31:15 volumio volumio[974]: info: Sep 04 15:31:15 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand stop took 219 milliseconds Sep 04 15:31:15 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:15 volumio volumio[974]: info: Sep 04 15:31:15 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:15 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:15 volumio volumio[974]: info: Sep 04 15:31:15 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:15 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand status took 23 milliseconds Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand status took 22 milliseconds Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand status took 22 milliseconds Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 04 15:31:15 volumio volumio[974]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:15 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:15 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 15:31:15 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 15:31:15 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 15:31:15 volumio volumio[974]: info: ------------------------------ 67ms Sep 04 15:31:15 volumio volumio[974]: info: ------------------------------ 64ms Sep 04 15:31:15 volumio volumio[974]: info: ------------------------------ 64ms Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 15:31:15 volumio volumio[974]: info: VolumeController:: Volume=86 Mute =false Sep 04 15:31:15 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:15 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:15 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:15 volumio volumio[974]: info: Asound.conf file written Sep 04 15:31:15 volumio sudo[11462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 04 15:31:15 volumio sudo[11462]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:15 volumio sudo[11462]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:16 volumio volumio[974]: info: Output device has changed, restarting MPD Sep 04 15:31:16 volumio sudo[11467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 15:31:16 volumio volumio[974]: info: Output device has changed, restarting Shairport Sync Sep 04 15:31:16 volumio sudo[11467]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 15:31:16 volumio sudo[11467]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:16 volumio sudo[11469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 15:31:16 volumio sudo[11469]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio systemd[1]: Stopping Music Player Daemon... Sep 04 15:31:16 volumio volumio[974]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 15:31:16 volumio volumio[974]: info: Output device has changed, restarting MPD Sep 04 15:31:16 volumio volumio[974]: info: Output device has changed, restarting Shairport Sync Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 15:31:16 volumio sudo[11477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 15:31:16 volumio sudo[11477]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio systemd[1]: Starting Cleanup of Temporary Directories... Sep 04 15:31:16 volumio systemd[1]: mpd.service: Succeeded. Sep 04 15:31:16 volumio sudo[11477]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:16 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 15:31:16 volumio sudo[11479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 15:31:16 volumio sudo[11479]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio systemd[1]: Starting Music Player Daemon... Sep 04 15:31:16 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Sep 04 15:31:16 volumio systemd[1]: Started Cleanup of Temporary Directories. Sep 04 15:31:16 volumio volumio[974]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 15:31:16 volumio volumio[974]: info: Sep 04 15:31:16 volumio volumio[974]: ---------------------------- MPD announces state update: mixer Sep 04 15:31:16 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 04 15:31:16 volumio systemd[1]: mpd.service: Succeeded. Sep 04 15:31:16 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:16 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:16 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 15:31:16 volumio volumio[974]: error: MPD error: Error: write EPIPE Sep 04 15:31:16 volumio volumio[974]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Sep 04 15:31:16 volumio systemd[1]: Starting Music Player Daemon... Sep 04 15:31:16 volumio volumio[974]: info: Sep 04 15:31:16 volumio volumio[974]: ---------------------------- MPD announces state update: mixer Sep 04 15:31:16 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:16 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:16 volumio volumio[974]: error: MPD error: Error: write EPIPE Sep 04 15:31:16 volumio volumio[974]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Sep 04 15:31:16 volumio volumio[974]: info: Sep 04 15:31:16 volumio volumio[974]: ---------------------------- MPD announces state update: mixer Sep 04 15:31:16 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:16 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:16 volumio volumio[974]: error: MPD error: Error: write EPIPE Sep 04 15:31:16 volumio volumio[974]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Sep 04 15:31:16 volumio volumio[974]: info: MPD Permissions set Sep 04 15:31:16 volumio volumio[974]: info: MPD Permissions set Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 15:31:16 volumio volumio[974]: info: Starting Shairport Sync Sep 04 15:31:16 volumio volumio[974]: info: Starting Shairport Sync Sep 04 15:31:16 volumio sudo[11496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 15:31:16 volumio sudo[11496]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio sudo[11486]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 15:31:16 volumio sudo[11486]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio sudo[11498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 15:31:16 volumio sudo[11498]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 15:31:16 volumio sudo[11486]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 15:31:16 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 15:31:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 15:31:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 15:31:16 volumio sudo[11496]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:16 volumio sudo[11498]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:16 volumio volumio[974]: info: Shairport-Sync Started Sep 04 15:31:16 volumio volumio[974]: info: Shairport-Sync Started Sep 04 15:31:17 volumio mpd[11502]: Sep 04 15:31 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 15:31:17 volumio systemd[1]: Started Music Player Daemon. Sep 04 15:31:17 volumio sudo[11479]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:17 volumio sudo[11469]: pam_unix(sudo:session): session closed for user root Sep 04 15:31:17 volumio volumio[974]: error: MPD error: The expression evaluated to a falsy value: Sep 04 15:31:17 volumio volumio[974]: assert.ok(self.idling) Sep 04 15:31:17 volumio volumio[974]: error: The expression evaluated to a falsy value: Sep 04 15:31:17 volumio volumio[974]: assert.ok(self.idling) Sep 04 15:31:17 volumio volumio[974]: error: updateQueue error: null Sep 04 15:31:18 volumio volumio[974]: info: CoreCommandRouter::volumioPlay Sep 04 15:31:18 volumio volumio[974]: info: CoreStateMachine::play index undefined Sep 04 15:31:18 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 15:31:18 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:18 volumio volumio[974]: info: CoreStateMachine::startPlaybackTimer Sep 04 15:31:18 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:18 volumio volumio[974]: info: [1756971078918] ControllerWebradio::clearAddPlayTrack Sep 04 15:31:18 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 15:31:18 volumio volumio[974]: info: sendMpdCommand stop took 1 milliseconds Sep 04 15:31:18 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 15:31:18 volumio volumio[974]: info: Sep 04 15:31:18 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:18 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:18 volumio volumio[974]: info: sendMpdCommand clear took 2 milliseconds Sep 04 15:31:18 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand add "http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8" Sep 04 15:31:18 volumio volumio[974]: info: Sep 04 15:31:18 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:18 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:18 volumio volumio[974]: error: updateQueue error: null Sep 04 15:31:18 volumio volumio[974]: info: Sep 04 15:31:18 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:18 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:18 volumio volumio[974]: info: ------------------------------ 5ms Sep 04 15:31:18 volumio volumio[974]: info: sendMpdCommand add "http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8" took 4 milliseconds Sep 04 15:31:18 volumio volumio[974]: info: ------------------------------ 3ms Sep 04 15:31:18 volumio volumio[974]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 15:31:18 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand play Sep 04 15:31:18 volumio volumio[974]: info: Sep 04 15:31:18 volumio volumio[974]: ---------------------------- MPD announces system playlist update Sep 04 15:31:18 volumio volumio[974]: info: Ignoring MPD Status Update Sep 04 15:31:18 volumio volumio[974]: info: ------------------------------ 5ms Sep 04 15:31:18 volumio volumio[974]: info: sendMpdCommand play took 4 milliseconds Sep 04 15:31:18 volumio volumio[974]: info: ------------------------------ 3ms Sep 04 15:31:19 volumio volumio[974]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 04 15:31:19 volumio volumio[974]: info: CoreStateMachine::getcurrentVolume Sep 04 15:31:19 volumio volumio[974]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 15:31:19 volumio volumio[974]: info: VolumeController:: Volume=86 Mute =false Sep 04 15:31:19 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:19 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:19 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:19 volumio volumio[974]: info: CoreStateMachine::updateTrackBlock Sep 04 15:31:19 volumio volumio[974]: info: CorePlayQueue::getTrackBlock Sep 04 15:31:19 volumio volumio[974]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 15:31:19 volumio volumio[974]: info: VolumeController:: Volume=86 Mute =false Sep 04 15:31:19 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:19 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:19 volumio volumio[974]: error: Upnp client error: Error: This socket has been ended by the other party Sep 04 15:31:20 volumio volumio[974]: info: Sep 04 15:31:20 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:20 volumio volumio[974]: info: Sep 04 15:31:20 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:20 volumio volumio[974]: info: Sep 04 15:31:20 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand status took 5 milliseconds Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand status took 4 milliseconds Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand status took 4 milliseconds Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:20 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus stop Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:20 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:20 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:20 volumio volumio[974]: info: ------------------------------ 34ms Sep 04 15:31:20 volumio volumio[974]: info: ------------------------------ 50ms Sep 04 15:31:20 volumio volumio[974]: info: Sep 04 15:31:20 volumio volumio[974]: ---------------------------- MPD announces state update: player Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::getState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand status Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand playlistinfo took 42 milliseconds Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand status took 3 milliseconds Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseState Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:20 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:20 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:20 volumio volumio[974]: info: ------------------------------ 84ms Sep 04 15:31:20 volumio volumio[974]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 04 15:31:20 volumio volumio[974]: verbose: ControllerMpd::parseTrackInfo Sep 04 15:31:20 volumio volumio[974]: info: ControllerMpd::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::servicePushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64.m3u8","artist":null,"album":null,"uri":"http://live.ximalaya.com/radio-first-page-app/live/141/64.m3u8","trackType":"m3u8"} Sep 04 15:31:20 volumio volumio[974]: verbose: CURRENT POSITION 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState stateService play Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::syncState currentStatus play Sep 04 15:31:20 volumio volumio[974]: info: Received an update from plugin. extracting info from payload Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:20 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:20 volumio volumio[974]: info: CoreStateMachine::pushState Sep 04 15:31:20 volumio volumio[974]: info: CoreCommandRouter::volumioPushState Sep 04 15:31:20 volumio volumio[974]: info: ------------------------------ 75ms Sep 04 15:31:51 volumio nmbd[740]: [2025/09/04 15:31:51.589446, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 04 15:31:51 volumio nmbd[740]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.190 for name WORKGROUP<1d>. Sep 04 15:31:51 volumio nmbd[740]: This response was from IP 192.168.2.102, reporting an IP address of 192.168.2.102. Sep 04 15:31:51 volumio nmbd[740]: [2025/09/04 15:31:51.591680, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 04 15:31:51 volumio nmbd[740]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.120 for name WORKGROUP<1d>. Sep 04 15:31:51 volumio nmbd[740]: This response was from IP 192.168.2.102, reporting an IP address of 192.168.2.102. Sep 04 15:32:11 volumio volumio[974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 15:32:11 volumio volumio[974]: Error: connect ETIMEDOUT 108.160.172.208:443 Sep 04 15:32:11 volumio volumio[974]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 04 15:32:11 volumio volumio[974]: errno: -110, Sep 04 15:32:11 volumio volumio[974]: code: 'ETIMEDOUT', Sep 04 15:32:11 volumio volumio[974]: syscall: 'connect', Sep 04 15:32:11 volumio volumio[974]: address: '108.160.172.208', Sep 04 15:32:11 volumio volumio[974]: port: 443 Sep 04 15:32:11 volumio volumio[974]: } Sep 04 15:32:11 volumio volumio[974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 15:32:11 volumio sudo[12064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-04 15:31 Sep 04 15:32:11 volumio sudo[12064]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"