-- Logs begin at Tue 2025-05-13 17:20:39 CEST, end at Tue 2025-05-13 17:53:30 CEST. -- May 13 17:52:06 volumio sudo[13426]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f May 13 17:52:06 volumio sudo[13426]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) May 13 17:52:10 volumio go-librespot[12333]: time="2025-05-13T17:52:10+02:00" level=trace msg="received accesspoint ping" May 13 17:52:10 volumio go-librespot[12333]: time="2025-05-13T17:52:10+02:00" level=trace msg="received accesspoint pong ack" May 13 17:52:10 volumio go-librespot[12333]: time="2025-05-13T17:52:10+02:00" level=trace msg="sent dealer ping" May 13 17:52:10 volumio go-librespot[12333]: time="2025-05-13T17:52:10+02:00" level=trace msg="received dealer pong" May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPrevious May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::previous May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::seek May 13 17:52:14 volumio volumio[12064]: error: null May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 1 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 2 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 1 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 24ms May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 21 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 21 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 56ms May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 57ms May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPrevious May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::previous May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::stPlaybackTimer May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::updateTrackBlock May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrackBlock May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::serviceStop May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::serviceStop May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::stop May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Handling event: musicStop May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand stop took 14 milliseconds May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 21 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 22 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 21 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 1 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: No code May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: No code May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 4 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus stop May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: No code May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 4 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 70ms May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: stop May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: info: touch_display: Setting screensaver timeout to 220 seconds. May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::play index undefined May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::startPlaybackTimer May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3 May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand stop May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand stop took 1 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand clear May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces system playlist update May 13 17:52:14 volumio volumio[12064]: info: Ignoring MPD Status Update May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand clear took 1 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3" May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces system playlist update May 13 17:52:14 volumio volumio[12064]: info: Ignoring MPD Status Update May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces system playlist update May 13 17:52:14 volumio volumio[12064]: info: Ignoring MPD Status Update May 13 17:52:14 volumio volumio[12064]: error: updateQueue error: null May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces system playlist update May 13 17:52:14 volumio volumio[12064]: info: Ignoring MPD Status Update May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 4ms May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand add "INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3" took 3 milliseconds May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 2ms May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 1ms May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand play May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces system playlist update May 13 17:52:14 volumio volumio[12064]: info: Ignoring MPD Status Update May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces system playlist update May 13 17:52:14 volumio volumio[12064]: info: Ignoring MPD Status Update May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 4ms May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand play took 3 milliseconds May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 3ms May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 2ms May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 3 milliseconds May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 3 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: May 13 17:52:14 volumio volumio[12064]: ---------------------------- MPD announces state update: player May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::getState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand status May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 4 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 4 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 3 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 3 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 2 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus stop May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 14ms May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 18ms May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand status took 14 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 13 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 14 milliseconds May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 13 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseState May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 58ms May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 58ms May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 56ms May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Handling event: musicPlay May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: info: sendMpdCommand playlistinfo took 87 milliseconds May 13 17:52:14 volumio volumio[12064]: verbose: ControllerMpd::parseTrackInfo May 13 17:52:14 volumio volumio[12064]: info: ControllerMpd::pushState May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::servicePushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Delta Phase: Chapterhouse","artist":"Global Communication","album":"Space Night III","uri":"INTERNAL/Space Night 3/Space Night III - Disc 1+2 - Global Communication - 03 - Delta Phase Chapterhouse.mp3","trackType":"mp3"} May 13 17:52:14 volumio volumio[12064]: verbose: CURRENT POSITION 3 May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState stateService play May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::syncState currentStatus play May 13 17:52:14 volumio volumio[12064]: info: Received an update from plugin. extracting info from payload May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: CoreStateMachine::pushState May 13 17:52:14 volumio volumio[12064]: info: CorePlayQueue::getTrack 3 May 13 17:52:14 volumio volumio[12064]: info: CoreCommandRouter::volumioPushState May 13 17:52:14 volumio volumio[12064]: info: ------------------------------ 118ms May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: info: [GPIO_Control] Status changed: play May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:14 volumio volumio[12064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 May 13 17:52:19 volumio volumio[12064]: info: CALLMETHOD: music_service mpd handleBrowseUri [object Object] May 13 17:52:19 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 13 17:52:19 volumio volumio[12064]: info: CURURI: [object Object] May 13 17:52:19 volumio volumio[12064]: error: Failed callmethod call: TypeError: curUri.split is not a function May 13 17:52:31 volumio volumio[12064]: info: CALLMETHOD: music_service mpd handleBrowseUri [object Object] May 13 17:52:31 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 13 17:52:31 volumio volumio[12064]: info: CURURI: [object Object] May 13 17:52:31 volumio volumio[12064]: error: Failed callmethod call: TypeError: curUri.split is not a function May 13 17:52:34 volumio sudo[13426]: pam_unix(sudo:session): session closed for user root May 13 17:52:40 volumio go-librespot[12333]: time="2025-05-13T17:52:40+02:00" level=trace msg="sent dealer ping" May 13 17:52:40 volumio go-librespot[12333]: time="2025-05-13T17:52:40+02:00" level=trace msg="received dealer pong" May 13 17:52:52 volumio wpa_supplicant[964]: RRM: Ignoring radio measurement request: Not RRM network May 13 17:52:54 volumio wpa_supplicant[964]: RRM: Ignoring radio measurement request: Not RRM network May 13 17:52:56 volumio wpa_supplicant[964]: RRM: Ignoring radio measurement request: Not RRM network May 13 17:52:58 volumio wpa_supplicant[964]: RRM: Ignoring radio measurement request: Not RRM network May 13 17:53:10 volumio go-librespot[12333]: time="2025-05-13T17:53:10+02:00" level=trace msg="sent dealer ping" May 13 17:53:10 volumio go-librespot[12333]: time="2025-05-13T17:53:10+02:00" level=trace msg="received dealer pong" May 13 17:53:20 volumio volumio[12064]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] May 13 17:53:20 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder May 13 17:53:20 volumio sudo[13627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:20 volumio sudo[13627]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:20 volumio sudo[13627]: pam_unix(sudo:session): session closed for user root May 13 17:53:20 volumio sudo[13630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 May 13 17:53:20 volumio sudo[13630]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:20 volumio kernel: input: button@4 as /devices/platform/button@4/input/input119 May 13 17:53:20 volumio sudo[13630]: pam_unix(sudo:session): session closed for user root May 13 17:53:20 volumio sudo[13643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:20 volumio sudo[13643]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:20 volumio sudo[13643]: pam_unix(sudo:session): session closed for user root May 13 17:53:20 volumio sudo[13647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:20 volumio sudo[13647]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:20 volumio sudo[13647]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 May 13 17:53:21 volumio sudo[13651]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio systemd-udevd[13635]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 13 17:53:21 volumio startx[1354]: [dix] couldn't enable device 10 May 13 17:53:21 volumio sudo[13651]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:21 volumio sudo[13661]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio sudo[13661]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:21 volumio sudo[13664]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio sudo[13664]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 May 13 17:53:21 volumio sudo[13667]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio kernel: input: button@11 as /devices/platform/button@11/input/input120 May 13 17:53:21 volumio sudo[13667]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:21 volumio sudo[13677]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio sudo[13677]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:21 volumio sudo[13681]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio sudo[13681]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 May 13 17:53:21 volumio sudo[13685]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio systemd-udevd[13635]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 13 17:53:21 volumio systemd-logind[652]: Failed to open /dev/input/event3: No such device May 13 17:53:21 volumio sudo[13685]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:21 volumio sudo[13694]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio sudo[13694]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio sudo[13697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=22 pin_b=23 relative_axis=true steps-per-period=1 May 13 17:53:21 volumio sudo[13697]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:21 volumio kernel: rotary-encoder rotary@16: gray May 13 17:53:21 volumio kernel: input: rotary@16 as /devices/platform/rotary@16/input/input121 May 13 17:53:21 volumio sudo[13697]: pam_unix(sudo:session): session closed for user root May 13 17:53:21 volumio systemd-udevd[13635]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 13 17:53:22 volumio sudo[13724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=17 active_low=1 gpio_pull=up keycode=20 May 13 17:53:22 volumio sudo[13724]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:22 volumio kernel: input: button@11 as /devices/platform/button@11/input/input122 May 13 17:53:22 volumio sudo[13724]: pam_unix(sudo:session): session closed for user root May 13 17:53:22 volumio systemd-udevd[13635]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 13 17:53:23 volumio sudo[13736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=24 pin_b=27 relative_axis=true steps-per-period=2 May 13 17:53:23 volumio sudo[13736]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:23 volumio kernel: rotary-encoder rotary@18: gray May 13 17:53:23 volumio kernel: input: rotary@18 as /devices/platform/rotary@18/input/input123 May 13 17:53:23 volumio sudo[13736]: pam_unix(sudo:session): session closed for user root May 13 17:53:23 volumio systemd-udevd[13635]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 13 17:53:24 volumio sudo[13749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=4 active_low=1 gpio_pull=up keycode=20 May 13 17:53:24 volumio sudo[13749]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:24 volumio kernel: input: button@4 as /devices/platform/button@4/input/input124 May 13 17:53:24 volumio sudo[13749]: pam_unix(sudo:session): session closed for user root May 13 17:53:24 volumio systemd-udevd[13635]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 13 17:53:25 volumio sudo[13761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:25 volumio sudo[13761]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:25 volumio sudo[13761]: pam_unix(sudo:session): session closed for user root May 13 17:53:25 volumio sudo[13765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:25 volumio sudo[13765]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:25 volumio sudo[13765]: pam_unix(sudo:session): session closed for user root May 13 17:53:25 volumio sudo[13769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:25 volumio sudo[13769]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:25 volumio sudo[13769]: pam_unix(sudo:session): session closed for user root May 13 17:53:25 volumio sudo[13773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 13 17:53:25 volumio sudo[13773]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 17:53:25 volumio sudo[13773]: pam_unix(sudo:session): session closed for user root May 13 17:53:29 volumio volumio[12064]: info: CALLMETHOD: music_service mpd handleBrowseUri albums:// May 13 17:53:29 volumio volumio[12064]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 13 17:53:29 volumio volumio[12064]: info: CURURI: albums:// May 13 17:53:29 volumio volumio[12064]: info: listAlbums - loading Albums from cache May 13 17:53:29 volumio volumio[12064]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 17:53:29 volumio volumio[12064]: Error: invalid payload May 13 17:53:29 volumio volumio[12064]: at decodeString (/data/plugins/system_hardware/rotaryencoder2/node_modules/socket.io-parser/index.js:355:13) May 13 17:53:29 volumio volumio[12064]: at Decoder.add (/data/plugins/system_hardware/rotaryencoder2/node_modules/socket.io-parser/index.js:245:14) May 13 17:53:29 volumio volumio[12064]: at Manager.ondata (/data/plugins/system_hardware/rotaryencoder2/node_modules/socket.io-client/lib/manager.js:339:16) May 13 17:53:29 volumio volumio[12064]: at Socket. (/data/plugins/system_hardware/rotaryencoder2/node_modules/component-bind/index.js:21:15) May 13 17:53:29 volumio volumio[12064]: at Socket.Emitter.emit (/data/plugins/system_hardware/rotaryencoder2/node_modules/component-emitter/index.js:145:20) May 13 17:53:29 volumio volumio[12064]: at Socket.onPacket (/data/plugins/system_hardware/rotaryencoder2/node_modules/engine.io-client/lib/socket.js:461:14) May 13 17:53:29 volumio volumio[12064]: at WS. (/data/plugins/system_hardware/rotaryencoder2/node_modules/engine.io-client/lib/socket.js:278:10) May 13 17:53:29 volumio volumio[12064]: at WS.Emitter.emit (/data/plugins/system_hardware/rotaryencoder2/node_modules/component-emitter/index.js:145:20) May 13 17:53:29 volumio volumio[12064]: at WS.Transport.onPacket (/data/plugins/system_hardware/rotaryencoder2/node_modules/engine.io-client/lib/transport.js:149:8) May 13 17:53:29 volumio volumio[12064]: at WS.Transport.onData (/data/plugins/system_hardware/rotaryencoder2/node_modules/engine.io-client/lib/transport.js:141:8) May 13 17:53:29 volumio volumio[12064]: at WebSocket.ws.onmessage (/data/plugins/system_hardware/rotaryencoder2/node_modules/engine.io-client/lib/transports/websocket.js:160:10) May 13 17:53:29 volumio volumio[12064]: at WebSocket.onMessage (/data/plugins/system_hardware/rotaryencoder2/node_modules/ws/lib/event-target.js:132:16) May 13 17:53:29 volumio volumio[12064]: at WebSocket.emit (events.js:315:20) May 13 17:53:29 volumio volumio[12064]: at Receiver.receiverOnMessage (/data/plugins/system_hardware/rotaryencoder2/node_modules/ws/lib/websocket.js:1070:20) May 13 17:53:29 volumio volumio[12064]: at Receiver.emit (events.js:315:20) May 13 17:53:29 volumio volumio[12064]: at Receiver.dataMessage (/data/plugins/system_hardware/rotaryencoder2/node_modules/ws/lib/receiver.js:517:14) May 13 17:53:29 volumio volumio[12064]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 17:53:30 volumio sudo[13786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 17:52 May 13 17:53:30 volumio sudo[13786]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"