-- Logs begin at Tue 2024-10-22 23:30:43 +05, end at Wed 2024-10-23 15:45:34 +05. -- Oct 23 15:44:20 volumio volumio[1168]: info: Oct 23 15:44:20 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:20 volumio volumio[1168]: info: Oct 23 15:44:20 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:20 volumio volumio[1168]: info: Oct 23 15:44:20 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:20 volumio volumio[1168]: info: Oct 23 15:44:20 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand status took 16 milliseconds Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand status took 16 milliseconds Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand status took 15 milliseconds Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand status took 15 milliseconds Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand clearerror took 34 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand clearerror took 32 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand clearerror took 32 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand clearerror took 30 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 23 15:44:20 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:20 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:20 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:20 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:20 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:20 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:20 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:20 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:20 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:20 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:20 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:20 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:20 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:20 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:20 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:20 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:20 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:20 volumio volumio[1168]: info: ------------------------------ 165ms Oct 23 15:44:20 volumio volumio[1168]: info: ------------------------------ 165ms Oct 23 15:44:20 volumio volumio[1168]: info: ------------------------------ 164ms Oct 23 15:44:20 volumio volumio[1168]: info: ------------------------------ 163ms Oct 23 15:44:20 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:44:26 volumio kernel: hwmon hwmon1: Voltage normalised Oct 23 15:44:29 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:44:29 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:44:29 volumio volumio[1168]: info: Discovery: Getting this device information Oct 23 15:44:29 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:44:29 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:44:42 volumio volumio[1168]: info: Oct 23 15:44:42 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:42 volumio volumio[1168]: info: Oct 23 15:44:42 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:42 volumio volumio[1168]: info: Oct 23 15:44:42 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:42 volumio volumio[1168]: info: Oct 23 15:44:42 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand status took 19 milliseconds Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand status took 19 milliseconds Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand status took 18 milliseconds Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand status took 18 milliseconds Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand clearerror took 27 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand clearerror took 26 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand clearerror took 25 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand clearerror took 23 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 23 15:44:42 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:42 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:42 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:42 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:42 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:42 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:42 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:42 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:42 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:42 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:42 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:42 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:42 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:42 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:42 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:42 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:42 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:42 volumio volumio[1168]: info: ------------------------------ 120ms Oct 23 15:44:42 volumio volumio[1168]: info: ------------------------------ 118ms Oct 23 15:44:42 volumio volumio[1168]: info: ------------------------------ 117ms Oct 23 15:44:42 volumio volumio[1168]: info: ------------------------------ 116ms Oct 23 15:44:43 volumio volumio[1168]: info: Oct 23 15:44:43 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:43 volumio volumio[1168]: info: Oct 23 15:44:43 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:43 volumio volumio[1168]: info: Oct 23 15:44:43 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:43 volumio volumio[1168]: info: Oct 23 15:44:43 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand status took 19 milliseconds Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand status took 19 milliseconds Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand status took 19 milliseconds Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand status took 18 milliseconds Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand clearerror took 27 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand clearerror took 25 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand clearerror took 25 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand clearerror took 23 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 23 15:44:43 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:43 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:43 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:43 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:43 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:43 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:43 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:43 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:43 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:43 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:43 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:43 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:43 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:43 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:43 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:43 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:43 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:43 volumio volumio[1168]: info: ------------------------------ 108ms Oct 23 15:44:43 volumio volumio[1168]: info: ------------------------------ 107ms Oct 23 15:44:43 volumio volumio[1168]: info: ------------------------------ 106ms Oct 23 15:44:43 volumio volumio[1168]: info: ------------------------------ 104ms Oct 23 15:44:56 volumio volumio[1168]: info: Oct 23 15:44:56 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:56 volumio volumio[1168]: info: Oct 23 15:44:56 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:56 volumio volumio[1168]: info: Oct 23 15:44:56 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:56 volumio volumio[1168]: info: Oct 23 15:44:56 volumio volumio[1168]: ---------------------------- MPD announces state update: player Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::getState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand status took 15 milliseconds Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand status took 15 milliseconds Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand status took 14 milliseconds Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand status took 14 milliseconds Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseState Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand clearerror took 27 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand clearerror took 25 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand clearerror took 25 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand clearerror took 23 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 23 15:44:56 volumio volumio[1168]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:56 volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:56 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:56 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:56 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:56 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:56 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:56 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:56 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:56 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:56 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:56 volumio volumio[1168]: info: ControllerMpd::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::servicePushState Oct 23 15:44:56 volumio volumio[1168]: verbose: In UPNP mode Oct 23 15:44:56 volumio volumio[1168]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Singing In The Shower","artist":"Les Rita Mitsouko, The Sparks","album":"Best Of & Raretés","uri":"http://192.168.0.24:40199/msp/MEDIA/1000005100/_data/1000005100.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:44:56 volumio volumio[1168]: verbose: CURRENT POSITION 0 Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState stateService pause Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:44:56 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:44:56 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:44:56 volumio volumio[1168]: info: ------------------------------ 118ms Oct 23 15:44:56 volumio volumio[1168]: info: ------------------------------ 117ms Oct 23 15:44:56 volumio volumio[1168]: info: ------------------------------ 116ms Oct 23 15:44:56 volumio volumio[1168]: info: ------------------------------ 115ms Oct 23 15:44:59 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:44:59 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:44:59 volumio volumio[1168]: info: Discovery: Getting this device information Oct 23 15:44:59 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:44:59 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 23 15:45:04 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:45:09 volumio volumio[1168]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 23 15:45:09 volumio volumio[1168]: info: Preparing to save Alsa Options, stopping services first Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:09 volumio volumio[1168]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"NAD USB Audio 2.0"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:09 volumio volumio[1168]: info: Setting mixer Analogue 18 for card NAD USB Audio 2.0 Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 23 15:45:09 volumio volumio[1168]: info: Updating Volume Controller Parameters: Device: 5 Name: NAD USB Audio 2.0 Mixer: Analogue 18 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 23 15:45:09 volumio volumio[1168]: info: Disabling external Volume Control Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:45:09 volumio volumio[1168]: info: Preparing to generate the ALSA configuration file Oct 23 15:45:09 volumio volumio[1168]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Oct 23 15:45:09 volumio volumio[1168]: info: Reading ALSA contributions from plugins. Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:45:09 volumio volumio[1168]: info: VolumeController:: Volume=100 Mute =false Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:09 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:45:09 volumio volumio[1168]: info: Asound.conf file unchanged, so no further update is needed Oct 23 15:45:09 volumio volumio[1168]: info: Output device has changed, restarting MPD Oct 23 15:45:09 volumio sudo[1852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 23 15:45:09 volumio sudo[1852]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:09 volumio volumio[1168]: info: Output device has changed, restarting Shairport Sync Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:09 volumio sudo[1852]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:09 volumio sudo[1856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 23 15:45:09 volumio sudo[1856]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:09 volumio volumio[1168]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 23 15:45:09 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 23 15:45:09 volumio volumio[1168]: info: MPD Permissions set Oct 23 15:45:09 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 23 15:45:09 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio systemd[1]: Stopping Music Player Daemon... Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:09 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:09 volumio volumio[1168]: info: Starting Shairport Sync Oct 23 15:45:09 volumio sudo[1865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 23 15:45:09 volumio sudo[1865]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:10 volumio systemd[1]: mpd.service: Succeeded. Oct 23 15:45:10 volumio systemd[1]: Stopped Music Player Daemon. Oct 23 15:45:10 volumio systemd[1]: Starting Music Player Daemon... Oct 23 15:45:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 23 15:45:10 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 23 15:45:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 23 15:45:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 23 15:45:10 volumio sudo[1865]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:10 volumio volumio[1168]: info: Shairport-Sync Started Oct 23 15:45:10 volumio sudo[1867]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 23 15:45:10 volumio sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:10 volumio sudo[1867]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:10 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:45:13 volumio mpd[1872]: Oct 23 15:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 23 15:45:13 volumio systemd[1]: Started Music Player Daemon. Oct 23 15:45:13 volumio sudo[1856]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:13 volumio volumio[1168]: error: updateQueue error: null Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 23 15:45:13 volumio volumio[1168]: info: CoreStateMachine::getcurrentVolume Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioRetrievevolume Oct 23 15:45:13 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Oct 23 15:45:13 volumio volumio[1168]: info: VolumeController:: Volume=100 Mute =false Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:13 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:45:13 volumio volumio[1168]: info: CoreStateMachine::updateTrackBlock Oct 23 15:45:13 volumio volumio[1168]: info: CorePlayQueue::getTrackBlock Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioRetrievevolume Oct 23 15:45:13 volumio volumio[1168]: info: VolumeController:: Volume=100 Mute =false Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:13 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:45:13 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:45:14 volumio volumio[1914]: cset: --> shielding system active with Oct 23 15:45:14 volumio volumio[1914]: cset: "system" cpuset of CPUSPEC(1-3) with 132 tasks running Oct 23 15:45:14 volumio volumio[1914]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Oct 23 15:45:14 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Oct 23 15:45:16 volumio kernel: hwmon hwmon1: Voltage normalised Oct 23 15:45:29 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:45:29 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:45:29 volumio volumio[1168]: info: Discovery: Getting this device information Oct 23 15:45:29 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:29 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:45:30 volumio volumio[1168]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Oct 23 15:45:30 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 23 15:45:30 volumio volumio[1168]: info: Preparing to save Alsa Options, stopping services first Oct 23 15:45:30 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:30 volumio volumio[1168]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"NAD USB Audio 2.0"},"i2s":true,"i2sid":{"value":"502-dac","label":"PI 2 Design 502DAC"}} Oct 23 15:45:30 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:30 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 23 15:45:30 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:30 volumio volumio[1168]: info: Enabling I2S DAC: PI 2 Design 502DAC Oct 23 15:45:30 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:31 volumio sudo[1936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 23 15:45:31 volumio sudo[1936]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:31 volumio sudo[1936]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:31 volumio volumio[1168]: info: No Overlays Loaded Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:31 volumio sudo[1939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dacplus Oct 23 15:45:31 volumio sudo[1939]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:31 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Oct 23 15:45:31 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status Oct 23 15:45:31 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Oct 23 15:45:31 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Oct 23 15:45:31 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Oct 23 15:45:31 volumio volumio[1168]: warn: Unable to locate the device NAD USB Audio 2.0 a reboot may be required. Oct 23 15:45:31 volumio sudo[1939]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:31 volumio volumio[1168]: info: Found match in i2s Card Database: setting mixer Digital for card PI 2 Design 502DAC Oct 23 15:45:31 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:45:31 volumio kernel: pinctrl-bcm2835 3f200000.gpio: pin gpio18 already requested by ir-receiver@12; cannot claim for 3f203000.i2s Oct 23 15:45:31 volumio kernel: pinctrl-bcm2835 3f200000.gpio: pin-18 (3f203000.i2s) status -22 Oct 23 15:45:31 volumio kernel: pinctrl-bcm2835 3f200000.gpio: could not request pin 18 (gpio18) from group gpio18 on device pinctrl-bcm2835 Oct 23 15:45:31 volumio kernel: bcm2835-i2s 3f203000.i2s: Error applying setting, reverse things back Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 23 15:45:31 volumio volumio[1168]: info: Updating Volume Controller Parameters: Device: 2 Name: PI 2 Design 502DAC Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 23 15:45:31 volumio volumio[1168]: info: Disabling external Volume Control Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Oct 23 15:45:31 volumio volumio[1168]: info: Preparing to generate the ALSA configuration file Oct 23 15:45:31 volumio volumio[1168]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Oct 23 15:45:31 volumio volumio[1168]: info: Reading ALSA contributions from plugins. Oct 23 15:45:31 volumio volumio[1168]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 23 15:45:31 volumio volumio[1168]: info: I2S Param [object Object] successfully enabled Oct 23 15:45:31 volumio volumio[1168]: info: VolumeController:: Volume=undefined Mute =false Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:31 volumio volumio[1168]: info: CoreStateMachine::pushState Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:31 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:45:31 volumio volumio[1168]: info: Getting Alsa Cards List without I2S DAC Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: Invalid card number. Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:45:32 volumio volumio[1168]: info: Asound.conf file written Oct 23 15:45:32 volumio sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 23 15:45:32 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:32 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:32 volumio volumio[1168]: info: Output device has changed, restarting MPD Oct 23 15:45:32 volumio sudo[1991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 23 15:45:32 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:32 volumio volumio[1168]: info: Output device has changed, restarting Shairport Sync Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:32 volumio sudo[1991]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:32 volumio sudo[1994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 23 15:45:32 volumio sudo[1994]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:32 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 23 15:45:32 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 23 15:45:32 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 23 15:45:32 volumio systemd[1]: Stopping Music Player Daemon... Oct 23 15:45:32 volumio volumio[1168]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 23 15:45:32 volumio volumio[1168]: info: Output device has changed, restarting MPD Oct 23 15:45:32 volumio systemd[1]: mpd.service: Succeeded. Oct 23 15:45:32 volumio systemd[1]: Stopped Music Player Daemon. Oct 23 15:45:32 volumio volumio[1168]: info: Output device has changed, restarting Shairport Sync Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:32 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:32 volumio sudo[2001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 23 15:45:32 volumio sudo[2001]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:32 volumio systemd[1]: Starting Music Player Daemon... Oct 23 15:45:32 volumio sudo[2001]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:32 volumio sudo[2004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 23 15:45:32 volumio sudo[2004]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:33 volumio volumio[1168]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 23 15:45:33 volumio volumio[1168]: info: MPD Permissions set Oct 23 15:45:33 volumio volumio[1168]: info: MPD Permissions set Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 23 15:45:33 volumio systemd[1]: mpd.service: Succeeded. Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio systemd[1]: Stopped Music Player Daemon. Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio systemd[1]: Starting Music Player Daemon... Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:45:33 volumio volumio[1168]: info: Starting Shairport Sync Oct 23 15:45:33 volumio volumio[1168]: info: Starting Shairport Sync Oct 23 15:45:33 volumio sudo[2009]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 23 15:45:33 volumio sudo[2009]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:33 volumio sudo[2009]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:33 volumio sudo[2020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 23 15:45:33 volumio sudo[2020]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:33 volumio volumio[1168]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Oct 23 15:45:33 volumio volumio[1168]: info: PLUGIN onReboot : networkfs Oct 23 15:45:33 volumio volumio[1168]: info: PLUGIN onReboot : audiophonicsonoff Oct 23 15:45:33 volumio volumio[1168]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 15:45:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 23 15:45:33 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 23 15:45:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 23 15:45:33 volumio volumio[1168]: TypeError: Cannot read property 'writeSync' of undefined Oct 23 15:45:33 volumio volumio[1168]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Oct 23 15:45:33 volumio volumio[1168]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Oct 23 15:45:33 volumio volumio[1168]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Oct 23 15:45:33 volumio volumio[1168]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 23 15:45:33 volumio volumio[1168]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 23 15:45:33 volumio volumio[1168]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Oct 23 15:45:33 volumio volumio[1168]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Oct 23 15:45:33 volumio volumio[1168]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Oct 23 15:45:33 volumio volumio[1168]: at Socket.emit (events.js:315:20) Oct 23 15:45:33 volumio volumio[1168]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 23 15:45:33 volumio volumio[1168]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 23 15:45:33 volumio volumio[1168]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 15:45:33 volumio sudo[2023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 23 15:45:33 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 23 15:45:33 volumio sudo[2023]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:45:33 volumio sudo[2020]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 23 15:45:33 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 23 15:45:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 23 15:45:33 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 23 15:45:33 volumio sudo[2023]: pam_unix(sudo:session): session closed for user root Oct 23 15:45:34 volumio sudo[2040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-23 15:44 Oct 23 15:45:34 volumio sudo[2040]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"