Oct 16 13:25:00 volumio volumio[1128]: info: Oct 16 13:25:00 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand stop took 679 milliseconds Oct 16 13:25:00 volumio volumio[1128]: info: ControllerMpd::getState Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand stop took 364 milliseconds Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 13:25:00 volumio volumio[1128]: info: Oct 16 13:25:00 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 16 13:25:00 volumio volumio[1128]: info: ControllerMpd::getState Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 16 13:25:00 volumio volumio[1128]: info: Oct 16 13:25:00 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 16 13:25:00 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand status took 85 milliseconds Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand clear took 82 milliseconds Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand status took 82 milliseconds Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536742" Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 16 13:25:00 volumio volumio[1128]: info: ControllerMpd::pushState Oct 16 13:25:00 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 16 13:25:00 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:00 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 16 13:25:00 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:00 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:00 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 16 13:25:00 volumio volumio[1128]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 16 13:25:00 volumio volumio[1128]: info: ------------------------------ 207ms Oct 16 13:25:00 volumio volumio[1128]: info: Oct 16 13:25:00 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 16 13:25:00 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 16 13:25:00 volumio volumio[1128]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Oct 16 13:25:00 volumio volumio[1128]: error: updateQueue error: null Oct 16 13:25:00 volumio volumio[1128]: info: ------------------------------ 196ms Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 140 milliseconds Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 16 13:25:00 volumio volumio[1128]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 16 13:25:00 volumio volumio[1128]: info: ------------------------------ 290ms Oct 16 13:25:00 volumio volumio[1128]: info: Oct 16 13:25:00 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 16 13:25:00 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536742" took 157 milliseconds Oct 16 13:25:00 volumio volumio[1128]: info: ------------------------------ 53ms Oct 16 13:25:00 volumio volumio[1128]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 16 13:25:00 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand play Oct 16 13:25:00 volumio volumio[1128]: info: Oct 16 13:25:00 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 16 13:25:00 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 16 13:25:00 volumio volumio[1128]: info: ------------------------------ 9ms Oct 16 13:25:00 volumio volumio[1128]: info: sendMpdCommand play took 6 milliseconds Oct 16 13:25:00 volumio volumio[1128]: info: ------------------------------ 5ms Oct 16 13:25:03 volumio volumio[1128]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 16 13:25:03 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 16 13:25:03 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 13:25:03 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 13:25:03 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 13:25:04 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:04.546-03:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 16 13:25:04 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:04.554-03:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 16 13:25:04 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:04.554-03:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 16 13:25:04 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:04.554-03:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Oct 16 13:25:04 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 13:25:04 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 13:25:04 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 13:25:05 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 13:25:05 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 13:25:06 volumio volumio[1128]: info: Oct 16 13:25:06 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 16 13:25:06 volumio volumio[1128]: info: ControllerMpd::getState Oct 16 13:25:06 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 16 13:25:06 volumio volumio[1128]: info: Oct 16 13:25:06 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 16 13:25:06 volumio volumio[1128]: info: ControllerMpd::getState Oct 16 13:25:06 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 16 13:25:06 volumio volumio[1128]: info: Oct 16 13:25:06 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 16 13:25:06 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 16 13:25:06 volumio volumio[1128]: info: Oct 16 13:25:06 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 16 13:25:06 volumio volumio[1128]: info: ControllerMpd::getState Oct 16 13:25:06 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 16 13:25:06 volumio volumio[1128]: info: Oct 16 13:25:06 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 16 13:25:06 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 16 13:25:06 volumio volumio[1128]: info: Oct 16 13:25:06 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 16 13:25:06 volumio volumio[1128]: info: sendMpdCommand status took 130 milliseconds Oct 16 13:25:06 volumio volumio[1128]: info: ControllerMpd::getState Oct 16 13:25:06 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 16 13:25:06 volumio volumio[1128]: info: sendMpdCommand status took 129 milliseconds Oct 16 13:25:06 volumio volumio[1128]: info: ------------------------------ 7ms Oct 16 13:25:06 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 16 13:25:06 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 13:25:07 volumio volumio[1128]: info: sendMpdCommand status took 203 milliseconds Oct 16 13:25:07 volumio volumio[1128]: info: ------------------------------ 207ms Oct 16 13:25:07 volumio volumio[1128]: info: sendMpdCommand status took 208 milliseconds Oct 16 13:25:07 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 215 milliseconds Oct 16 13:25:07 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 48 milliseconds Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 16 13:25:07 volumio volumio[1128]: info: ControllerMpd::pushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 16 13:25:07 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 16 13:25:07 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1082,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sade - King Of Sorrow","artist":"Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Oct 16 13:25:07 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Oct 16 13:25:07 volumio volumio[1128]: info: ControllerMpd::pushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 16 13:25:07 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 16 13:25:07 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1185,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sade - King Of Sorrow","artist":"Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Oct 16 13:25:07 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus play Oct 16 13:25:07 volumio volumio[1128]: info: Received an update from plugin. extracting info from payload Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:07 volumio volumio[1128]: info: ------------------------------ 652ms Oct 16 13:25:07 volumio volumio[1128]: info: ------------------------------ 1123ms Oct 16 13:25:07 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 758 milliseconds Oct 16 13:25:07 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 748 milliseconds Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 16 13:25:07 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 16 13:25:07 volumio volumio[1128]: info: ControllerMpd::pushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 16 13:25:07 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 16 13:25:07 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1185,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sade - King Of Sorrow","artist":"Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Oct 16 13:25:07 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus play Oct 16 13:25:07 volumio volumio[1128]: info: Received an update from plugin. extracting info from payload Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 16 13:25:07 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:07 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:08 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:08 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:08 volumio volumio[1128]: info: ControllerMpd::pushState Oct 16 13:25:08 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 16 13:25:08 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 16 13:25:08 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1288,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sade - King Of Sorrow","artist":"Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Oct 16 13:25:08 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 16 13:25:08 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 16 13:25:08 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus play Oct 16 13:25:08 volumio volumio[1128]: info: Received an update from plugin. extracting info from payload Oct 16 13:25:08 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 16 13:25:08 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:08 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:08 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:08 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:08 volumio volumio[1128]: info: ------------------------------ 1474ms Oct 16 13:25:08 volumio volumio[1128]: info: ------------------------------ 1516ms Oct 16 13:25:08 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:08.868-03:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=gRuDw8VOllNskO9rDnQKN97pvq53 tokenExpiry=2026-10-16T14:25:08.868-03:00 Oct 16 13:25:14 volumio volumio[1128]: info: CoreCommandRouter::volumioGetState Oct 16 13:25:15 volumio volumio[1128]: info: Received Get System Info Oct 16 13:25:15 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 13:25:15 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 13:25:15 volumio volumio[1128]: info: Discovery: Getting this device information Oct 16 13:25:15 volumio volumio[1128]: info: CoreCommandRouter::volumioGetState Oct 16 13:25:15 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 13:25:15 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 13:25:15 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 13:25:15 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:15.963-03:00 level=INFO msg="enabling local network discovery" Oct 16 13:25:17 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:17.557-03:00 level=INFO msg="enabling BLE discovery" Oct 16 13:25:20 volumio volumio5-onboarding[2357]: time=2026-10-16T13:25:20.439-03:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 16 13:25:55 volumio volumio[1128]: info: VolumeController::SetAlsaVolume24 Oct 16 13:25:55 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:55 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:55 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:55 volumio volumio[1128]: info: VolumeController::SetAlsaVolume32 Oct 16 13:25:56 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:56 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:56 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:56 volumio volumio[1128]: info: VolumeController::SetAlsaVolume55 Oct 16 13:25:56 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:56 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:56 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:57 volumio volumio[1128]: info: VolumeController::SetAlsaVolume56 Oct 16 13:25:57 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:57 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:57 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:57 volumio volumio[1128]: info: VolumeController::SetAlsaVolume59 Oct 16 13:25:57 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:57 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:57 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:57 volumio volumio[1128]: info: VolumeController::SetAlsaVolume58 Oct 16 13:25:57 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:57 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:57 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:58 volumio volumio[1128]: info: VolumeController::SetAlsaVolume57 Oct 16 13:25:58 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:58 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:58 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:25:58 volumio volumio[1128]: info: VolumeController::SetAlsaVolume56 Oct 16 13:25:58 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:25:58 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:25:58 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:26:00 volumio volumio[1128]: info: VolumeController::SetAlsaVolume53 Oct 16 13:26:00 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 16 13:26:00 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:26:00 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 16 13:26:05 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 13:26:05 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 13:26:12 volumio volumio[1128]: info: Disabling plugin mpd_oled Oct 16 13:26:12 volumio volumio[1128]: info: Preparing to generate the ALSA configuration file Oct 16 13:26:13 volumio volumio[1128]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 16 13:26:13 volumio volumio[1128]: info: Reading ALSA contributions from plugins. Oct 16 13:26:13 volumio sudo[2489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd_oled_plugin.service Oct 16 13:26:13 volumio sudo[2489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:13 volumio volumio[1128]: info: Asound.conf file written Oct 16 13:26:13 volumio sudo[2496]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 16 13:26:13 volumio sudo[2496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:13 volumio sudo[2496]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:13 volumio sudo[2489]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:14 volumio volumio[1128]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 16 13:26:14 volumio volumio[1128]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Oct 16 13:26:14 volumio volumio[1128]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Oct 16 13:26:14 volumio volumio[1128]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Oct 16 13:26:14 volumio volumio[1128]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Oct 16 13:26:14 volumio volumio[1128]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Oct 16 13:26:14 volumio volumio[1128]: info: Output device has changed, restarting MPD Oct 16 13:26:14 volumio sudo[2502]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 13:26:14 volumio sudo[2502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:14 volumio sudo[2502]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:14 volumio volumio[1128]: info: Output device has changed, restarting Shairport Sync Oct 16 13:26:14 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:26:14 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:26:14 volumio sudo[2505]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 13:26:14 volumio sudo[2505]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:14 volumio volumio[1128]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 13:26:14 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 16 13:26:14 volumio volumio[1128]: info: Done. Oct 16 13:26:14 volumio volumio[1128]: info: touch_display: Un-/commenting gpu_mem settings in /boot/config.txt. Oct 16 13:26:14 volumio sudo[2513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 16 13:26:14 volumio sudo[2513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:14 volumio sudo[2517]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Oct 16 13:26:14 volumio sudo[2517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:14 volumio sudo[2513]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:14 volumio sudo[2515]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Oct 16 13:26:14 volumio sudo[2515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:14 volumio volumio[1128]: info: touch_display: Using /boot/config.txt instead of /boot/userconfig.txt. Oct 16 13:26:14 volumio sudo[2520]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Oct 16 13:26:14 volumio sudo[2520]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 13:26:14 volumio volumio[1128]: info: MPD Permissions set Oct 16 13:26:14 volumio volumio[1128]: info: [MPD_OLED Plugin] Stopped mpd_oled_plugin service Oct 16 13:26:15 volumio volumio[1128]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Oct 16 13:26:15 volumio volumio[1128]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 13:26:15 volumio volumio[1128]: TypeError: Cannot read properties of undefined (reading 'split') Oct 16 13:26:15 volumio volumio[1128]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Oct 16 13:26:15 volumio volumio[1128]: at ChildProcess.exithandler (node:child_process:413:7) Oct 16 13:26:15 volumio volumio[1128]: at ChildProcess.emit (node:events:514:28) Oct 16 13:26:15 volumio volumio[1128]: at maybeClose (node:internal/child_process:1105:16) Oct 16 13:26:15 volumio volumio[1128]: at Socket. (node:internal/child_process:457:11) Oct 16 13:26:15 volumio volumio[1128]: at Socket.emit (node:events:514:28) Oct 16 13:26:15 volumio volumio[1128]: at Pipe. (node:net:337:12) Oct 16 13:26:15 volumio volumio[1128]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 13:26:15 volumio systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 16 13:26:15 volumio systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 16 13:26:15 volumio systemd[1]: Reloading. Oct 16 13:26:15 volumio sudo[2515]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:19 volumio sudo[2517]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:19 volumio sudo[2520]: pam_unix(sudo:session): session closed for user root Oct 16 13:26:23 volumio sudo[2576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 13:25' Oct 16 13:26:23 volumio sudo[2576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"