Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 25 21:14:03 volumio volumio[1265]: info: Preparing to save Alsa Options, stopping services first Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:03 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::volumioPause Jan 25 21:14:03 volumio volumio[1265]: info: CoreStateMachine::pause Jan 25 21:14:03 volumio volumio[1265]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"hifiberry-dacplus","label":"HiFiBerry DAC Plus"},"output_device":{"value":1,"label":"HiFiBerry DAC Plus"},"disallowPush":true} Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: Enabling I2S DAC: HiFiBerry DAC Plus Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio sudo[26967]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 25 21:14:03 volumio sudo[26967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio sudo[26967]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: info: No Overlays Loaded Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio sudo[26970]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dacplus Jan 25 21:14:03 volumio sudo[26970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio volumio[1265]: warn: Unable to locate the device HiFiBerry DAC Plus a reboot may be required. Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@1000120000/rp1/i2s@a4000/status Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@1000120000/rp1/i2c@74000/#address-cells Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@1000120000/rp1/i2c@74000/#size-cells Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@1000120000/rp1/i2c@74000/status Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc@107c000000/sound/compatible Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc@107c000000/sound/i2s-controller Jan 25 21:14:03 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc@107c000000/sound/status Jan 25 21:14:03 volumio sudo[26970]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 25 21:14:03 volumio volumio[1265]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 25 21:14:03 volumio volumio[1265]: info: Disabling external Volume Control Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jan 25 21:14:03 volumio volumio[1265]: info: Preparing to generate the ALSA configuration file Jan 25 21:14:03 volumio kernel: pcm512x 1-004d: Failed to reset device: -121 Jan 25 21:14:03 volumio kernel: pcm512x 1-004d: probe with driver pcm512x failed with error -121 Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:03 volumio volumio[1265]: info: Retrieving Cloud Streaming UI Jan 25 21:14:03 volumio volumio[1265]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Jan 25 21:14:03 volumio volumio[1265]: info: I2S Param [object Object] successfully enabled Jan 25 21:14:03 volumio volumio[1265]: info: VolumeController:: Volume=undefined Mute =false Jan 25 21:14:03 volumio volumio[1265]: info: CoreStateMachine::pushState Jan 25 21:14:03 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::volumioPushState Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 25 21:14:03 volumio volumio[1265]: info: Getting Alsa Cards List without I2S DAC Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: Invalid card number '2'. Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 25 21:14:03 volumio volumio[1265]: info: Getting Tidal Cloud Configuration Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:03 volumio volumio[1265]: info: Getting Qobuz Cloud Configuration Jan 25 21:14:03 volumio volumio[1265]: info: Asking plugin for UI Config Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:03 volumio volumio[1265]: info: Getting Spotify Cloud Configuration Jan 25 21:14:03 volumio volumio[1265]: info: Asking plugin for UI Config Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:03 volumio volumio[1265]: info: Saving Spotify Acccount Jan 25 21:14:03 volumio volumio[1265]: info: Got Tidal Cloud Configuration Jan 25 21:14:03 volumio volumio[1265]: info: Got it Jan 25 21:14:03 volumio volumio[1265]: info: Got it Jan 25 21:14:03 volumio volumio[1265]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 25 21:14:03 volumio volumio[1265]: info: Asound.conf file written Jan 25 21:14:03 volumio sudo[27022]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 25 21:14:03 volumio sudo[27022]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio sudo[27022]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 25 21:14:03 volumio volumio[1265]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 25 21:14:03 volumio volumio[1265]: info: Output device has changed, restarting MPD Jan 25 21:14:03 volumio volumio[1265]: info: Output device has changed, restarting Shairport Sync Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 25 21:14:03 volumio sudo[27030]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 25 21:14:03 volumio volumio[1265]: info: Output device has changed, restarting MPD Jan 25 21:14:03 volumio sudo[27030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio sudo[27029]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 25 21:14:03 volumio sudo[27029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio sudo[27029]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: info: Output device has changed, restarting Shairport Sync Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio sudo[27038]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 25 21:14:03 volumio sudo[27038]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 25 21:14:03 volumio sudo[27038]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 25 21:14:03 volumio sudo[27040]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 25 21:14:03 volumio sudo[27040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio volumio[1265]: info: MPD Permissions set Jan 25 21:14:03 volumio volumio[1265]: info: MPD Permissions set Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:03 volumio volumio[1265]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:03 volumio volumio[1265]: info: Starting Shairport Sync Jan 25 21:14:03 volumio volumio[1265]: info: Starting Shairport Sync Jan 25 21:14:03 volumio sudo[27058]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 25 21:14:03 volumio sudo[27058]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio sudo[27061]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 25 21:14:03 volumio sudo[27061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:03 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 25 21:14:03 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 25 21:14:03 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 25 21:14:03 volumio systemd[1]: shairport-sync.service: Consumed 20.666s CPU time. Jan 25 21:14:03 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 25 21:14:03 volumio sudo[27058]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 25 21:14:03 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 25 21:14:03 volumio systemd[1]: mpd.service: Consumed 1.630s CPU time. Jan 25 21:14:03 volumio volumio[1265]: info: Shairport-Sync Started Jan 25 21:14:03 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 25 21:14:03 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 25 21:14:03 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 25 21:14:03 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 25 21:14:03 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 25 21:14:03 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 25 21:14:03 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 25 21:14:03 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 25 21:14:03 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 25 21:14:03 volumio sudo[27061]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: info: Shairport-Sync Started Jan 25 21:14:03 volumio sudo[27073]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 25 21:14:03 volumio sudo[27073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 21:14:03 volumio sudo[27073]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio mpd[27092]: 2026-01-25T21:14:03 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 25 21:14:03 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 25 21:14:03 volumio sudo[27030]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio sudo[27040]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:03 volumio volumio[1265]: error: updateQueue error: null Jan 25 21:14:03 volumio volumio[1265]: error: updateQueue error: null Jan 25 21:14:06 volumio sudo[27110]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 25 21:14:06 volumio sudo[27110]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:06 volumio sudo[27112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 25 21:14:06 volumio sudo[27112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:07 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Jan 25 21:14:07 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Jan 25 21:14:07 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Jan 25 21:14:07 volumio systemd[1]: mpd_monitor.service: Consumed 4.850s CPU time. Jan 25 21:14:07 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 25 21:14:07 volumio mpd_monitor.sh[27115]: MPD Monitor Service: Starting MPD Monitor Service Jan 25 21:14:07 volumio sudo[27112]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:07 volumio sudo[27110]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:07 volumio volumio[1265]: info: Successfully started MPD Monitor Jan 25 21:14:07 volumio volumio[1265]: info: Successfully started MPD Monitor Jan 25 21:14:07 volumio volumio[1265]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 25 21:14:07 volumio volumio[1265]: info: CoreStateMachine::getcurrentVolume Jan 25 21:14:07 volumio volumio[1265]: info: CoreCommandRouter::volumioRetrievevolume Jan 25 21:14:07 volumio volumio[1265]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Jan 25 21:14:07 volumio volumio[1265]: info: VolumeController:: Volume=undefined Mute =false Jan 25 21:14:07 volumio volumio[1265]: info: CoreStateMachine::pushState Jan 25 21:14:07 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:07 volumio volumio[1265]: info: CoreCommandRouter::volumioPushState Jan 25 21:14:07 volumio volumio[1265]: info: CoreStateMachine::updateTrackBlock Jan 25 21:14:07 volumio volumio[1265]: info: CorePlayQueue::getTrackBlock Jan 25 21:14:07 volumio volumio[1265]: info: CoreCommandRouter::volumioRetrievevolume Jan 25 21:14:07 volumio volumio[1265]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Jan 25 21:14:07 volumio volumio[1265]: info: VolumeController:: Volume=undefined Mute =false Jan 25 21:14:07 volumio volumio[1265]: info: CoreStateMachine::pushState Jan 25 21:14:07 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:07 volumio volumio[1265]: info: CoreCommandRouter::volumioPushState Jan 25 21:14:08 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Jan 25 21:14:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jan 25 21:14:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Jan 25 21:14:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Jan 25 21:14:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jan 25 21:14:14 volumio volumio[1265]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jan 25 21:14:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jan 25 21:14:14 volumio volumio[1265]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'value') Jan 25 21:14:14 volumio volumio[1265]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jan 25 21:14:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jan 25 21:14:14 volumio volumio[1265]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'value') Jan 25 21:14:15 volumio volumio[1265]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jan 25 21:14:15 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jan 25 21:14:15 volumio volumio[1265]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'value') Jan 25 21:14:17 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jan 25 21:14:17 volumio volumio[1265]: info: CoreCommandRouter::Reload Ui Jan 25 21:14:17 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Jan 25 21:14:17 volumio volumio[1265]: info: Wizard terminated Successfully Jan 25 21:14:17 volumio volumio[1265]: info: CoreCommandRouter::volumiosetStartupVolume Jan 25 21:14:17 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 21:14:17 volumio volumio[1265]: info: Player Reboot required after I2S DAC has been enabled in wizard Jan 25 21:14:18 volumio sudo[27152]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 25 21:14:18 volumio sudo[27152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:18 volumio sudo[27154]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:14:18 volumio sudo[27154]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:18 volumio sudo[27152]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:18 volumio sudo[27154]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:18 volumio volumio[1265]: verbose: New Socket.io Connection to 192.168.71.237 from 192.168.71.227 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 5 Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::volumioGetVisibleSources Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:18 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 25 21:14:18 volumio volumio[1265]: info: Received Get System Info Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 25 21:14:18 volumio volumio[1265]: info: Discovery: Getting this device information Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:18 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:18 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:18 volumio volumio[1265]: info: Listing playlists Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 25 21:14:18 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 25 21:14:18 volumio sudo[27158]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 25 21:14:18 volumio sudo[27158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:18 volumio sudo[27160]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:14:18 volumio sudo[27160]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:18 volumio sudo[27158]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:18 volumio sudo[27160]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:19 volumio volumio[1265]: verbose: New Socket.io Connection to 192.168.71.237 from 192.168.71.227 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 5 Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::volumioGetVisibleSources Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:19 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 25 21:14:19 volumio volumio[1265]: info: Received Get System Info Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 25 21:14:19 volumio volumio[1265]: info: Discovery: Getting this device information Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:19 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:19 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:19 volumio volumio[1265]: info: Listing playlists Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 25 21:14:19 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 25 21:14:20 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 25 21:14:20 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 25 21:14:20 volumio volumio[1265]: info: Received Get System Info Jan 25 21:14:20 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 25 21:14:20 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 25 21:14:20 volumio volumio[1265]: info: Discovery: Getting this device information Jan 25 21:14:20 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState Jan 25 21:14:20 volumio volumio[1265]: info: CorePlayQueue::getTrack 0 Jan 25 21:14:20 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 25 21:14:29 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 25 21:14:45 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jan 25 21:14:55 volumio volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 21:14:55 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 25 21:14:55 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 25 21:14:55 volumio sudo[27232]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jan 25 21:14:55 volumio sudo[27232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:55 volumio sudo[27237]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 25 21:14:55 volumio sudo[27237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:55 volumio sudo[27244]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 25 21:14:55 volumio sudo[27244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:55 volumio sudo[27237]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:55 volumio sudo[27244]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:55 volumio sudo[27232]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:55 volumio sudo[27249]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 25 21:14:55 volumio sudo[27249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:55 volumio sudo[27255]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 25 21:14:55 volumio sudo[27255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:55 volumio sudo[27259]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:14:55 volumio sudo[27259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:55 volumio sudo[27249]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:55 volumio sudo[27259]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:55 volumio sudo[27255]: pam_unix(sudo:session): session closed for user root Jan 25 21:14:55 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jan 25 21:14:55 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jan 25 21:14:55 volumio sudo[27264]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 25 21:14:55 volumio sudo[27264]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:14:56 volumio sudo[27264]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:24 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Jan 25 21:15:24 volumio volumio[1265]: info: Saving new wireless network Jan 25 21:15:24 volumio sudo[27322]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Jan 25 21:15:24 volumio sudo[27322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:24 volumio sudo[27322]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:24 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jan 25 21:15:24 volumio volumio[1265]: info: Discovery: Restarting Advertising due to device name change Jan 25 21:15:24 volumio sudo[27325]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jan 25 21:15:24 volumio sudo[27325]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:24 volumio systemd[1]: Stopping wireless.service - Wireless Services... Jan 25 21:15:24 volumio systemd[1]: wireless.service: Deactivated successfully. Jan 25 21:15:24 volumio systemd[1]: Stopped wireless.service - Wireless Services. Jan 25 21:15:24 volumio systemd[1]: Starting wireless.service - Wireless Services... Jan 25 21:15:24 volumio wireless.js[27327]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Jan 25 21:15:24 volumio wireless.js[27327]: WIRELESS.JS: Wired network status changed to: ---connected--- Jan 25 21:15:24 volumio wireless.js[27327]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 25 21:15:24 volumio wireless.js[27327]: WIRELESS.JS: Cleaning previous... Jan 25 21:15:24 volumio sudo[27345]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 25 21:15:24 volumio sudo[27345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 21:15:24 volumio sudo[27345]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:24 volumio sudo[27347]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 25 21:15:24 volumio sudo[27347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 21:15:25 volumio sudo[27347]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:25 volumio wireless.js[27327]: WIRELESS.JS: Stopped aP Jan 25 21:15:25 volumio sudo[27355]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 21:15:25 volumio sudo[27355]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:25 volumio sudo[27355]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:25 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 21:15:25 volumio sudo[27357]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 25 21:15:25 volumio sudo[27357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:25 volumio sudo[27357]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:25 volumio sudo[27365]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 21:15:25 volumio sudo[27365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:25 volumio sudo[27365]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:25 volumio sudo[27367]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 25 21:15:25 volumio sudo[27367]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:25 volumio volumio[1265]: info: Discovery: A device disappeared from network Jan 25 21:15:25 volumio volumio[1265]: info: Discovery: Device volumio disappeared from network Jan 25 21:15:25 volumio volumio[1265]: info: Discovery: A device disappeared from network Jan 25 21:15:25 volumio sudo[27372]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:15:25 volumio sudo[27372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:25 volumio sudo[27372]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:26 volumio sudo[27367]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:26 volumio wireless.js[27327]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: CN Jan 25 21:15:26 volumio sudo[27390]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 21:15:26 volumio sudo[27390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:26 volumio sudo[27390]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:26 volumio sudo[27392]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN Jan 25 21:15:26 volumio sudo[27392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:26 volumio sudo[27392]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:26 volumio wireless.js[27327]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: CN Jan 25 21:15:26 volumio wireless.js[27327]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Jan 25 21:15:26 volumio wireless.js[27327]: WIRELESS.JS: Notified systemd about wireless ready Jan 25 21:15:26 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 21:15:26 volumio systemd[1]: Started wireless.service - Wireless Services. Jan 25 21:15:26 volumio sudo[27325]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:26 volumio sudo[27400]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:15:26 volumio sudo[27400]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:26 volumio sudo[27400]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:27 volumio sudo[27406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:15:27 volumio sudo[27406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:27 volumio sudo[27406]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:28 volumio sudo[27409]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:15:28 volumio sudo[27409]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:28 volumio sudo[27409]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:29 volumio volumio[1265]: info: Discovery: Started advertising with name: Volumio Jan 25 21:15:29 volumio sudo[27413]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 21:15:29 volumio sudo[27413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 21:15:29 volumio sudo[27413]: pam_unix(sudo:session): session closed for user root Jan 25 21:15:30 volumio volumio[1265]: compat.c: read() failed: Resource temporarily unavailable Jan 25 21:15:30 volumio volumio[1265]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 21:15:30 volumio volumio[1265]: Error: dns service error: unknown Jan 25 21:15:30 volumio volumio[1265]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jan 25 21:15:30 volumio volumio[1265]: errorCode: -65537 Jan 25 21:15:30 volumio volumio[1265]: } Jan 25 21:15:30 volumio volumio[1265]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 21:15:30 volumio sudo[27430]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-25 21:14' Jan 25 21:15:30 volumio sudo[27430]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"