Feb 24 17:36:07 volumio volumio[1429]: info: CALLMETHOD: system_hardware pi_screen_setup saveStep4 [object Object] Feb 24 17:36:07 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: pi_screen_setup , saveStep4 Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: Saving Step 4 KMS - {"cma_option":{"value":"medium","label":"Medium (128MB)"},"cma_custom_mb":256} Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig called, will trigger after 100ms Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig timeout - calling getUIConfig Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: getUIConfig - wizardStep=5, wizardComplete=false, migrationState=none (cache=none, stepCache=5) Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: getUIConfig - checkMigration=false Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: OTA drift section hidden=true (driftDetected=false, wizardComplete=false) Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: Section 1 - default hidden, checkMigration=false, migrationState=none Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: populateWizardSections - wizardStep=5, wizardComplete=false Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: populateWizardSections - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: Step 0 section hidden=true (wizardStep=5, migrationState=none) Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: Step 1 section hidden=true (wizardStep=5) Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: Step 2 HDMI section hidden=true (showHdmi=false, primaryOutput=hdmi0) Feb 24 17:36:07 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig - broadcasting pushUiConfig Feb 24 17:36:14 volumio volumio[1429]: info: CALLMETHOD: system_hardware pi_screen_setup saveStep5 [object Object] Feb 24 17:36:14 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: pi_screen_setup , saveStep5 Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: Saving Step 5 OTA - {"ota_behavior":{"value":"notify","label":"Notify and restore"}} Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig called, will trigger after 100ms Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig timeout - calling getUIConfig Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: getUIConfig - wizardStep=6, wizardComplete=false, migrationState=none (cache=none, stepCache=6) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: getUIConfig - checkMigration=false Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: OTA drift section hidden=true (driftDetected=false, wizardComplete=false) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: Section 1 - default hidden, checkMigration=false, migrationState=none Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: populateWizardSections - wizardStep=6, wizardComplete=false Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: populateWizardSections - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: Step 0 section hidden=true (wizardStep=6, migrationState=none) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: Step 1 section hidden=true (wizardStep=6) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: Step 2 HDMI section hidden=true (showHdmi=false, primaryOutput=hdmi0) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - displayPreset=auto Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - rotation=0 Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - wizardDataCache={"primary_output":"hdmi0","hdmi0.enabled":true,"hdmi1.enabled":false,"dsi0.enabled":false,"dsi1.enabled":false,"dpi.enabled":false,"composite.enabled":false,"custom_overlay.enabled":false,"hdmi0.mode":"screen_audio","hdmi0.display_preset":"auto","hdmi0.custom_timings":"","hdmi0.custom_params":"","hdmi0.force_hotplug":false,"hdmi0.ignore_edid":false,"hdmi0.boost":0,"hdmi1.mode":"none","hdmi1.display_preset":"auto","hdmi1.force_hotplug":false,"hdmi1.ignore_edid":false,"hdmi1.boost":0,"hdmi0.rotation":0,"cmdline_rotation.video":true,"cmdline_rotation.fbcon":true,"cmdline_rotation.plymouth":true,"kms.cma_option":"medium","kms.cma_custom_mb":256,"ota_behavior":"notify"} Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - cmaOption=medium Feb 24 17:36:14 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig - broadcasting pushUiConfig Feb 24 17:36:18 volumio volumio[1429]: info: CALLMETHOD: system_hardware pi_screen_setup applyConfiguration [object Object] Feb 24 17:36:18 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: pi_screen_setup , applyConfiguration Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: Applying configuration Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - displayPreset=auto Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - rotation=0 Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - wizardDataCache={"primary_output":"hdmi0","hdmi0.enabled":true,"hdmi1.enabled":false,"dsi0.enabled":false,"dsi1.enabled":false,"dpi.enabled":false,"composite.enabled":false,"custom_overlay.enabled":false,"hdmi0.mode":"screen_audio","hdmi0.display_preset":"auto","hdmi0.custom_timings":"","hdmi0.custom_params":"","hdmi0.force_hotplug":false,"hdmi0.ignore_edid":false,"hdmi0.boost":0,"hdmi1.mode":"none","hdmi1.display_preset":"auto","hdmi1.force_hotplug":false,"hdmi1.ignore_edid":false,"hdmi1.boost":0,"hdmi0.rotation":0,"cmdline_rotation.video":true,"cmdline_rotation.fbcon":true,"cmdline_rotation.plymouth":true,"kms.cma_option":"medium","kms.cma_custom_mb":256,"ota_behavior":"notify"} Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - cmaOption=medium Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: Created restore point 2026-02-24T17-36-18-885Z with 3 files Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: Created restore point 2026-02-24T17-36-18-885Z before applying changes Feb 24 17:36:18 volumio volumio[1429]: info: pi_screen_setup: Created backup /data/plugins/system_hardware/pi_screen_setup/backups/videoconfig.txt.2026-02-24T17-36-18-920Z.bak Feb 24 17:36:18 volumio sudo[7231]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp /tmp/pi_screen_setup_videoconfig.txt /boot/videoconfig.txt Feb 24 17:36:18 volumio sudo[7231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:18 volumio sudo[7231]: pam_unix(sudo:session): session closed for user root Feb 24 17:36:19 volumio sudo[7235]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 644 /boot/videoconfig.txt Feb 24 17:36:19 volumio sudo[7235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:19 volumio sudo[7235]: pam_unix(sudo:session): session closed for user root Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Written /boot/videoconfig.txt Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Include line already present in config.txt Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: updateCmdline - primaryOutput=hdmi0 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: updateCmdline - rotation=0, displayPreset=auto Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: updateCmdline - new cmdline: _bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no fbcon=rotate:0 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Created backup /data/plugins/system_hardware/pi_screen_setup/backups/cmdline.txt.2026-02-24T17-36-19-084Z.bak Feb 24 17:36:19 volumio sudo[7239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp /tmp/pi_screen_setup_cmdline.txt /boot/cmdline.txt Feb 24 17:36:19 volumio sudo[7239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:19 volumio sudo[7239]: pam_unix(sudo:session): session closed for user root Feb 24 17:36:19 volumio sudo[7243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 644 /boot/cmdline.txt Feb 24 17:36:19 volumio sudo[7243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:19 volumio sudo[7243]: pam_unix(sudo:session): session closed for user root Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Written /boot/cmdline.txt Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Updated cmdline.txt Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Starting migration detection... Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: volumioconfig.txt content length: 683 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Found 0 lines in volumioconfig.txt Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: userconfig.txt content length: 307 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Found 0 lines in userconfig.txt: [] Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Migration detection complete - needed: false, lines: 0 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - displayPreset=auto Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - rotation=0 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - wizardDataCache={"primary_output":"hdmi0","hdmi0.enabled":true,"hdmi1.enabled":false,"dsi0.enabled":false,"dsi1.enabled":false,"dpi.enabled":false,"composite.enabled":false,"custom_overlay.enabled":false,"hdmi0.mode":"screen_audio","hdmi0.display_preset":"auto","hdmi0.custom_timings":"","hdmi0.custom_params":"","hdmi0.force_hotplug":false,"hdmi0.ignore_edid":false,"hdmi0.boost":0,"hdmi1.mode":"none","hdmi1.display_preset":"auto","hdmi1.force_hotplug":false,"hdmi1.ignore_edid":false,"hdmi1.boost":0,"hdmi0.rotation":0,"cmdline_rotation.video":true,"cmdline_rotation.fbcon":true,"cmdline_rotation.plymouth":true,"kms.cma_option":"medium","kms.cma_custom_mb":256,"ota_behavior":"notify"} Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - cmaOption=medium Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Saved current config to /data/plugins/system_hardware/pi_screen_setup/backups/current Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig called, will trigger after 100ms Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig timeout - calling getUIConfig Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: getUIConfig - wizardStep=7, wizardComplete=true, migrationState=none (cache=none, stepCache=7) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: getUIConfig - checkMigration=false Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: OTA drift section hidden=true (driftDetected=false, wizardComplete=true) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Section 1 - default hidden, checkMigration=false, migrationState=none Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: populateWizardSections - wizardStep=7, wizardComplete=true Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: populateWizardSections - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Step 0 section hidden=true (wizardStep=7, migrationState=none) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Step 1 section hidden=true (wizardStep=7) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: Step 2 HDMI section hidden=true (showHdmi=false, primaryOutput=hdmi0) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - primaryOutput=hdmi0 (cache=hdmi0) Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - displayPreset=auto Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - rotation=0 Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - wizardDataCache={"primary_output":"hdmi0","hdmi0.enabled":true,"hdmi1.enabled":false,"dsi0.enabled":false,"dsi1.enabled":false,"dpi.enabled":false,"composite.enabled":false,"custom_overlay.enabled":false,"hdmi0.mode":"screen_audio","hdmi0.display_preset":"auto","hdmi0.custom_timings":"","hdmi0.custom_params":"","hdmi0.force_hotplug":false,"hdmi0.ignore_edid":false,"hdmi0.boost":0,"hdmi1.mode":"none","hdmi1.display_preset":"auto","hdmi1.force_hotplug":false,"hdmi1.ignore_edid":false,"hdmi1.boost":0,"hdmi0.rotation":0,"cmdline_rotation.video":true,"cmdline_rotation.fbcon":true,"cmdline_rotation.plymouth":true,"kms.cma_option":"medium","kms.cma_custom_mb":256,"ota_behavior":"notify"} Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: generateConfigSummary - cmaOption=medium Feb 24 17:36:19 volumio volumio[1429]: info: pi_screen_setup: refreshUIConfig - broadcasting pushUiConfig Feb 24 17:36:27 volumio volumio[1429]: info: CoreCommandRouter::Close All Modals sent Feb 24 17:36:30 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 24 17:36:30 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 24 17:36:44 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 24 17:36:45 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 24 17:36:53 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 24 17:36:53 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 24 17:36:59 volumio volumio[1429]: info: Enabling plugin peppymeterbasic Feb 24 17:36:59 volumio volumio[1429]: info: Loading plugin "peppymeterbasic"... Feb 24 17:36:59 volumio volumio[1429]: info: Preparing to generate the ALSA configuration file Feb 24 17:36:59 volumio volumio[1429]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 24 17:36:59 volumio volumio[1429]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 24 17:36:59 volumio volumio[1429]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 24 17:36:59 volumio volumio[1429]: info: Reading ALSA contributions from plugins. Feb 24 17:36:59 volumio volumio[1429]: info: Asound.conf file written Feb 24 17:36:59 volumio sudo[7327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 24 17:36:59 volumio sudo[7327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:59 volumio sudo[7327]: pam_unix(sudo:session): session closed for user root Feb 24 17:36:59 volumio volumio[1429]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 24 17:36:59 volumio volumio[1429]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 24 17:36:59 volumio volumio[1429]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 24 17:36:59 volumio volumio[1429]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Feb 24 17:36:59 volumio volumio[1429]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:4 use case configuration -2 Feb 24 17:36:59 volumio volumio[1429]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:5 use case configuration -2 Feb 24 17:36:59 volumio volumio[1429]: info: Output device has changed, restarting MPD Feb 24 17:36:59 volumio volumio[1429]: info: Output device has changed, restarting Shairport Sync Feb 24 17:36:59 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:36:59 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 17:36:59 volumio sudo[7333]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 24 17:36:59 volumio sudo[7333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:59 volumio sudo[7333]: pam_unix(sudo:session): session closed for user root Feb 24 17:36:59 volumio sudo[7335]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 24 17:36:59 volumio sudo[7335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:36:59 volumio volumio[1429]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 24 17:36:59 volumio volumio[1429]: info: PLUGIN START: peppymeterbasic Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 24 17:37:00 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 24 17:37:00 volumio volumio[1429]: info: Preparing to generate the ALSA configuration file Feb 24 17:37:00 volumio sudo[7343]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Feb 24 17:37:00 volumio sudo[7343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:37:00 volumio volumio[1429]: info: Done. Feb 24 17:37:00 volumio sudo[7343]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:00 volumio volumio[1429]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 24 17:37:00 volumio volumio[1429]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 24 17:37:00 volumio volumio[1429]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 24 17:37:00 volumio volumio[1429]: info: Reading ALSA contributions from plugins. Feb 24 17:37:00 volumio volumio[1429]: info: snd_dummy loaded Feb 24 17:37:00 volumio volumio[1429]: info: MPD Permissions set Feb 24 17:37:00 volumio volumio[1429]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: Starting Shairport Sync Feb 24 17:37:00 volumio sudo[7351]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 24 17:37:00 volumio sudo[7351]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:37:00 volumio volumio[1429]: info: Asound.conf file unchanged, so no further update is needed Feb 24 17:37:00 volumio volumio[1429]: info: Output device has changed, restarting MPD Feb 24 17:37:00 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 24 17:37:00 volumio volumio[1429]: info: Output device has changed, restarting Shairport Sync Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 17:37:00 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 24 17:37:00 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 24 17:37:00 volumio systemd[1]: shairport-sync.service: Consumed 9.917s CPU time. Feb 24 17:37:00 volumio sudo[7354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 24 17:37:00 volumio sudo[7354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:37:00 volumio sudo[7354]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:00 volumio volumio[1429]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 24 17:37:00 volumio sudo[7356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 24 17:37:00 volumio sudo[7356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:37:00 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 24 17:37:00 volumio sudo[7351]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:00 volumio volumio[1429]: info: MPD Permissions set Feb 24 17:37:00 volumio volumio[1429]: info: Shairport-Sync Started Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 17:37:00 volumio volumio[1429]: info: Starting Shairport Sync Feb 24 17:37:00 volumio sudo[7388]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 24 17:37:00 volumio sudo[7388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 17:37:00 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 24 17:37:00 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 24 17:37:00 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 24 17:37:00 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 24 17:37:00 volumio sudo[7388]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:00 volumio volumio[1429]: info: Shairport-Sync Started Feb 24 17:37:01 volumio volumio[1429]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 17:37:05 volumio volumio[1429]: info: CoreCommandRouter::volumioGetState Feb 24 17:37:05 volumio volumio[1429]: info: CorePlayQueue::getTrack 0 Feb 24 17:37:05 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 24 17:37:05 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 24 17:37:05 volumio systemd[1]: mpd.service: Consumed 2.391s CPU time. Feb 24 17:37:05 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 24 17:37:05 volumio volumio[1429]: error: [ytcr] Error connecting MPD: Feb 24 17:37:05 volumio volumio[1429]: (Error) read ECONNRESET Feb 24 17:37:05 volumio volumio[1429]: Error: read ECONNRESET Feb 24 17:37:05 volumio volumio[1429]: at Pipe.onStreamRead (node:internal/stream_base_commons:217:20) Feb 24 17:37:05 volumio volumio[1429]: Retrying in 5 seconds... Feb 24 17:37:05 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 24 17:37:05 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 24 17:37:05 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 24 17:37:05 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 24 17:37:05 volumio sudo[7408]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 24 17:37:05 volumio sudo[7408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 24 17:37:05 volumio sudo[7408]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:07 volumio mpd[7410]: 2026-02-24T17:37:07 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 24 17:37:07 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 24 17:37:07 volumio sudo[7356]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:07 volumio sudo[7335]: pam_unix(sudo:session): session closed for user root Feb 24 17:37:07 volumio volumio[1429]: error: MPD error: The expression evaluated to a falsy value: Feb 24 17:37:07 volumio volumio[1429]: assert.ok(self.idling) Feb 24 17:37:07 volumio volumio[1429]: error: The expression evaluated to a falsy value: Feb 24 17:37:07 volumio volumio[1429]: assert.ok(self.idling) Feb 24 17:37:07 volumio volumio[1429]: error: updateQueue error: null Feb 24 17:37:07 volumio volumio[1429]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Feb 24 17:37:07 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Feb 24 17:37:07 volumio volumio[1429]: aaaaaaaaaaa 800,480 Feb 24 17:37:07 volumio volumio[1429]: info: PeppyMeterBasic ---800480 Feb 24 17:37:07 volumio volumio[1429]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 24 17:37:07 volumio volumio[1429]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 17:37:07 volumio volumio[1429]: info: CoreCommandRouter::Close All Modals sent Feb 24 17:37:35 volumio volumio[1429]: info: CALLMETHOD: user_interface peppymeterbasic updatelist Feb 24 17:37:35 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , updatelist Feb 24 17:37:35 volumio volumio[1429]: info: PeppyMeterBasic --- wget 'https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt' Feb 24 17:37:35 volumio volumio[1429]: --2026-02-24 17:37:35-- https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt Feb 24 17:37:35 volumio volumio[1429]: Resolving github.com (github.com)... 20.26.156.215 Feb 24 17:37:35 volumio volumio[1429]: Connecting to github.com (github.com)|20.26.156.215|:443... connected. Feb 24 17:37:35 volumio volumio[1429]: HTTP request sent, awaiting response... 302 Found Feb 24 17:37:35 volumio volumio[1429]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt [following] Feb 24 17:37:35 volumio volumio[1429]: --2026-02-24 17:37:35-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt Feb 24 17:37:35 volumio volumio[1429]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.109.133, 185.199.110.133, ... Feb 24 17:37:35 volumio volumio[1429]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected. Feb 24 17:37:35 volumio volumio[1429]: HTTP request sent, awaiting response... 200 OK Feb 24 17:37:35 volumio volumio[1429]: Length: 362 [text/plain] Feb 24 17:37:35 volumio volumio[1429]: Saving to: '/data/plugins/user_interface/peppymeterbasic/meterslist.txt' Feb 24 17:37:35 volumio volumio[1429]: 0K 100% 2.49M=0s Feb 24 17:37:35 volumio volumio[1429]: 2026-02-24 17:37:35 (2.49 MB/s) - '/data/plugins/user_interface/peppymeterbasic/meterslist.txt' saved [362/362] Feb 24 17:37:35 volumio volumio[1429]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 17:37:35 volumio volumio[1429]: info: CoreCommandRouter::Close All Modals sent Feb 24 17:37:47 volumio node[5452]: /data/plugins/system_hardware/raspdac_mini_lcd/compositor/index.js:934 Feb 24 17:37:47 volumio node[5452]: buff = Buffer.alloc(320*240*2); Feb 24 17:37:47 volumio node[5452]: ^ Feb 24 17:37:47 volumio node[5452]: TypeError: Assignment to constant variable. Feb 24 17:37:47 volumio node[5452]: at volumio_listener. (/data/plugins/system_hardware/raspdac_mini_lcd/compositor/index.js:934:8) Feb 24 17:37:47 volumio node[5452]: at volumio_listener.emit (node:events:514:28) Feb 24 17:37:47 volumio node[5452]: at Timeout._onTimeout (/data/plugins/system_hardware/raspdac_mini_lcd/compositor/utils/volumiolistener.js:220:8) Feb 24 17:37:47 volumio node[5452]: at listOnTimeout (node:internal/timers:573:17) Feb 24 17:37:47 volumio node[5452]: at process.processTimers (node:internal/timers:514:7) Feb 24 17:37:47 volumio node[5452]: Node.js v20.5.1 Feb 24 17:37:47 volumio systemd[1]: rdmlcd.service: Main process exited, code=exited, status=1/FAILURE Feb 24 17:37:47 volumio systemd[1]: rdmlcd.service: Failed with result 'exit-code'. Feb 24 17:37:47 volumio systemd[1]: rdmlcd.service: Consumed 11.007s CPU time. Feb 24 17:37:48 volumio volumio[1429]: info: CALLMETHOD: user_interface peppymeterbasic updatelist Feb 24 17:37:48 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , updatelist Feb 24 17:37:48 volumio volumio[1429]: info: PeppyMeterBasic --- wget 'https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt' Feb 24 17:37:48 volumio volumio[1429]: --2026-02-24 17:37:48-- https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt Feb 24 17:37:48 volumio volumio[1429]: Resolving github.com (github.com)... 20.26.156.215 Feb 24 17:37:48 volumio volumio[1429]: Connecting to github.com (github.com)|20.26.156.215|:443... connected. Feb 24 17:37:48 volumio volumio[1429]: HTTP request sent, awaiting response... 302 Found Feb 24 17:37:48 volumio volumio[1429]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt [following] Feb 24 17:37:48 volumio volumio[1429]: --2026-02-24 17:37:48-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt Feb 24 17:37:48 volumio volumio[1429]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.111.133, 185.199.108.133, 185.199.109.133, ... Feb 24 17:37:48 volumio volumio[1429]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.111.133|:443... connected. Feb 24 17:37:48 volumio volumio[1429]: HTTP request sent, awaiting response... 200 OK Feb 24 17:37:48 volumio volumio[1429]: Length: 362 [text/plain] Feb 24 17:37:48 volumio volumio[1429]: Saving to: '/data/plugins/user_interface/peppymeterbasic/meterslist.txt' Feb 24 17:37:48 volumio volumio[1429]: 0K 100% 3.43M=0s Feb 24 17:37:48 volumio volumio[1429]: 2026-02-24 17:37:48 (3.43 MB/s) - '/data/plugins/user_interface/peppymeterbasic/meterslist.txt' saved [362/362] Feb 24 17:37:48 volumio volumio[1429]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 17:37:48 volumio volumio[1429]: info: CoreCommandRouter::Close All Modals sent Feb 24 17:37:48 volumio volumio[1429]: info: CALLMETHOD: user_interface peppymeterbasic dlmeter [object Object] Feb 24 17:37:48 volumio volumio[1429]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , dlmeter Feb 24 17:37:51 volumio volumio[1429]: --2026-02-24 17:37:48-- https://github.com/balbuze/Meter-peppymeter/raw/main/Zipped-folders/Choose Feb 24 17:37:51 volumio volumio[1429]: Resolving github.com (github.com)... 20.26.156.215 Feb 24 17:37:51 volumio volumio[1429]: Connecting to github.com (github.com)|20.26.156.215|:443... connected. Feb 24 17:37:51 volumio volumio[1429]: HTTP request sent, awaiting response... 404 Not Found Feb 24 17:37:51 volumio volumio[1429]: 2026-02-24 17:37:49 ERROR 404: Not Found. Feb 24 17:37:51 volumio volumio[1429]: --2026-02-24 17:37:49-- http://a/ Feb 24 17:37:51 volumio volumio[1429]: Resolving a (a)... failed: Device or resource busy. Feb 24 17:37:51 volumio volumio[1429]: wget: unable to resolve host address 'a' Feb 24 17:37:51 volumio volumio[1429]: --2026-02-24 17:37:49-- http://packet.zip/ Feb 24 17:37:51 volumio volumio[1429]: Resolving packet.zip (packet.zip)... 162.255.119.167 Feb 24 17:37:51 volumio volumio[1429]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Feb 24 17:37:51 volumio volumio[1429]: HTTP request sent, awaiting response... 302 Found Feb 24 17:37:51 volumio volumio[1429]: Location: http://www.packet.zip/ [following] Feb 24 17:37:51 volumio volumio[1429]: --2026-02-24 17:37:50-- http://www.packet.zip/ Feb 24 17:37:51 volumio volumio[1429]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Feb 24 17:37:51 volumio volumio[1429]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Feb 24 17:37:51 volumio volumio[1429]: HTTP request sent, awaiting response... Read error (Connection reset by peer) in headers. Feb 24 17:37:51 volumio volumio[1429]: Retrying. Feb 24 17:37:51 volumio volumio[1429]: --2026-02-24 17:37:51-- (try: 2) http://www.packet.zip/ Feb 24 17:37:51 volumio volumio[1429]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Feb 24 17:37:51 volumio volumio[1429]: HTTP request sent, awaiting response... 403 Forbidden Feb 24 17:37:51 volumio volumio[1429]: 2026-02-24 17:37:51 ERROR 403: Forbidden. Feb 24 17:37:51 volumio volumio[1429]: error: PeppyMeterBasic --- An error occurs while downloading or installing Meters Feb 24 17:37:51 volumio volumio[1429]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 24 17:37:51 volumio volumio[1429]: /bin/rm: cannot remove 'a': No such file or directory Feb 24 17:37:51 volumio volumio[1429]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 24 17:37:51 volumio volumio[1429]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 17:37:51 volumio volumio[1429]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Feb 24 17:37:51 volumio volumio[1429]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 24 17:37:51 volumio volumio[1429]: /bin/rm: cannot remove 'a': No such file or directory Feb 24 17:37:51 volumio volumio[1429]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 24 17:37:51 volumio volumio[1429]: at checkExecSyncError (node:child_process:887:11) Feb 24 17:37:51 volumio volumio[1429]: at execSync (node:child_process:959:15) Feb 24 17:37:51 volumio volumio[1429]: at /data/plugins/user_interface/peppymeterbasic/index.js:710:19 Feb 24 17:37:51 volumio volumio[1429]: at new Promise () Feb 24 17:37:51 volumio volumio[1429]: at peppymeterbasic.dlmeter (/data/plugins/user_interface/peppymeterbasic/index.js:685:12) Feb 24 17:37:51 volumio volumio[1429]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Feb 24 17:37:51 volumio volumio[1429]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Feb 24 17:37:51 volumio volumio[1429]: at Socket.emit (node:events:514:28) Feb 24 17:37:51 volumio volumio[1429]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 24 17:37:51 volumio volumio[1429]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Feb 24 17:37:51 volumio volumio[1429]: status: 1, Feb 24 17:37:51 volumio volumio[1429]: signal: null, Feb 24 17:37:51 volumio volumio[1429]: output: [ Feb 24 17:37:51 volumio volumio[1429]: null, Feb 24 17:37:51 volumio volumio[1429]: , Feb 24 17:37:51 volumio volumio[1429]: Feb 24 17:37:51 volumio volumio[1429]: ], Feb 24 17:37:51 volumio volumio[1429]: pid: 7505, Feb 24 17:37:51 volumio volumio[1429]: stdout: , Feb 24 17:37:51 volumio volumio[1429]: stderr: Feb 24 17:37:51 volumio volumio[1429]: } Feb 24 17:37:51 volumio volumio[1429]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 17:37:52 volumio sudo[7522]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 17:36' Feb 24 17:37:52 volumio sudo[7522]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"