Dec 15 09:52:07 volumio volumio[8805]: info: Enabling plugin peppyspectrum Dec 15 09:52:07 volumio volumio[8805]: info: Loading plugin "peppyspectrum"... Dec 15 09:52:07 volumio volumio[8805]: info: Preparing to generate the ALSA configuration file Dec 15 09:52:07 volumio volumio[8805]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 15 09:52:07 volumio volumio[8805]: info: Reading ALSA contributions from plugins. Dec 15 09:52:07 volumio volumio[8805]: info: Asound.conf file written Dec 15 09:52:07 volumio sudo[28132]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 15 09:52:07 volumio sudo[28132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:07 volumio sudo[28132]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:07 volumio volumio[8805]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 15 09:52:07 volumio volumio[8805]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 15 09:52:07 volumio volumio[8805]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 15 09:52:07 volumio volumio[8805]: info: Output device has changed, restarting MPD Dec 15 09:52:07 volumio volumio[8805]: info: Output device has changed, restarting Shairport Sync Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:07 volumio sudo[28140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 15 09:52:07 volumio sudo[28140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:07 volumio sudo[28142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:07 volumio sudo[28142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:07 volumio volumio[8805]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 15 09:52:07 volumio sudo[28140]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:07 volumio volumio[8805]: info: PLUGIN START: peppyspectrum Dec 15 09:52:07 volumio systemd[1]: musicservicesshield.service: Deactivated successfully. Dec 15 09:52:07 volumio systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 15 09:52:07 volumio systemd[1]: Stopping musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 15 09:52:07 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 15 09:52:07 volumio volumio[8805]: info: Preparing to generate the ALSA configuration file Dec 15 09:52:07 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:07 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:07 volumio systemd[1]: mpd.service: Consumed 37.537s CPU time. Dec 15 09:52:07 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:07 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:07 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:07 volumio sudo[28150]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 15 09:52:07 volumio volumio[8805]: info: Done. Dec 15 09:52:07 volumio sudo[28150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:07 volumio volumio[8805]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 15 09:52:07 volumio sudo[28150]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:07 volumio volumio[8805]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:07 volumio volumio[8805]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 15 09:52:07 volumio volumio[8805]: info: Reading ALSA contributions from plugins. Dec 15 09:52:07 volumio volumio[8805]: info: MPD Permissions set Dec 15 09:52:07 volumio volumio[8805]: info: snd_dummy loaded Dec 15 09:52:07 volumio volumio[8805]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:07 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:07 volumio volumio[8805]: info: Starting Shairport Sync Dec 15 09:52:07 volumio volumio[8805]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::volumioGetState Dec 15 09:52:07 volumio volumio[8805]: info: CorePlayQueue::getTrack 0 Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::volumioPause Dec 15 09:52:07 volumio volumio[8805]: info: CoreStateMachine::pause Dec 15 09:52:07 volumio volumio[8805]: info: CoreStateMachine::stPlaybackTimer Dec 15 09:52:07 volumio volumio[8805]: info: CoreStateMachine::servicePause Dec 15 09:52:07 volumio volumio[8805]: info: CorePlayQueue::getTrack 0 Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::servicePause Dec 15 09:52:07 volumio volumio[8805]: info: ControllerMpd::pause Dec 15 09:52:07 volumio volumio[8805]: verbose: ControllerMpd::sendMpdCommand pause Dec 15 09:52:07 volumio volumio[8805]: info: mpdhttpout --- Volumio set on pause Dec 15 09:52:07 volumio sudo[28161]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 15 09:52:07 volumio sudo[28161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:07 volumio volumio[8805]: info: Asound.conf file unchanged, so no further update is needed Dec 15 09:52:07 volumio volumio[8805]: info: Output device has changed, restarting MPD Dec 15 09:52:07 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 15 09:52:07 volumio volumio[8805]: info: Output device has changed, restarting Shairport Sync Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:07 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:07 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 15 09:52:07 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:07 volumio systemd[1]: shairport-sync.service: Consumed 9.941s CPU time. Dec 15 09:52:08 volumio volumio[8805]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 15 09:52:08 volumio sudo[28164]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 15 09:52:08 volumio sudo[28164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio sudo[28167]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:08 volumio sudo[28167]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:08 volumio sudo[28164]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:08 volumio sudo[28159]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:08 volumio sudo[28159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:08 volumio sudo[28159]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:08 volumio sudo[28161]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:08 volumio volumio[8805]: info: Shairport-Sync Started Dec 15 09:52:08 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:08 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:08 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:08 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:08 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:08 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:08 volumio volumio[8805]: info: MPD Permissions set Dec 15 09:52:08 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:08 volumio volumio[8805]: info: Starting Shairport Sync Dec 15 09:52:08 volumio volumio[8805]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Dec 15 09:52:08 volumio volumio[8805]: info: CoreCommandRouter::volumioGetState Dec 15 09:52:08 volumio volumio[8805]: info: CorePlayQueue::getTrack 0 Dec 15 09:52:08 volumio volumio[8805]: info: mpdhttpout --- Volumio set on pause Dec 15 09:52:08 volumio sudo[28200]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 15 09:52:08 volumio sudo[28200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:08 volumio sudo[28197]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:08 volumio sudo[28197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:08 volumio sudo[28197]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 15 09:52:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 15 09:52:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:08 volumio sudo[28200]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:08 volumio volumio[8805]: info: Shairport-Sync Started Dec 15 09:52:09 volumio mpd[28204]: 2025-12-15T09:52:09 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 15 09:52:09 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 15 09:52:09 volumio sudo[28167]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:09 volumio sudo[28142]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:09 volumio volumio[8805]: error: MPD error: The expression evaluated to a falsy value: Dec 15 09:52:09 volumio volumio[8805]: assert.ok(self.idling) Dec 15 09:52:09 volumio volumio[8805]: error: The expression evaluated to a falsy value: Dec 15 09:52:09 volumio volumio[8805]: assert.ok(self.idling) Dec 15 09:52:09 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Dec 15 09:52:10 volumio volumio[8805]: error: updateQueue error: null Dec 15 09:52:10 volumio systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 15 09:52:10 volumio sudo[28239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:10 volumio sudo[28239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:10 volumio systemd[1]: musicservicesshield.service: Main process exited, code=killed, status=15/TERM Dec 15 09:52:10 volumio systemd[1]: musicservicesshield.service: Failed with result 'signal'. Dec 15 09:52:10 volumio systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 15 09:52:10 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 15 09:52:10 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:10 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:10 volumio systemd[1]: mpd.service: Consumed 1.687s CPU time. Dec 15 09:52:10 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:10 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:10 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:10 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:10 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:10 volumio sudo[28253]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:10 volumio sudo[28253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:10 volumio sudo[28253]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:10 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Dec 15 09:52:10 volumio sudo[28257]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:10 volumio sudo[28257]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:10 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:10 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:10 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:10 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:10 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:10 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:10 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:10 volumio sudo[28261]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:10 volumio sudo[28261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:10 volumio sudo[28261]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:11 volumio mpd[28263]: 2025-12-15T09:52:11 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 15 09:52:12 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 15 09:52:12 volumio sudo[28239]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:12 volumio sudo[28257]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:12 volumio volumio[8805]: error: updateQueue error: null Dec 15 09:52:12 volumio volumio[8805]: error: updateQueue error: null Dec 15 09:52:12 volumio systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 15 09:52:12 volumio volumio[8805]: info: Enabling plugin peppyspectrum Dec 15 09:52:12 volumio volumio[8805]: info: Loading plugin "peppyspectrum"... Dec 15 09:52:12 volumio volumio[8805]: info: Preparing to generate the ALSA configuration file Dec 15 09:52:12 volumio volumio[8805]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 15 09:52:12 volumio volumio[8805]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 15 09:52:12 volumio volumio[8805]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:12 volumio volumio[8805]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:12 volumio volumio[8805]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 15 09:52:12 volumio volumio[8805]: info: Reading ALSA contributions from plugins. Dec 15 09:52:12 volumio volumio[8805]: info: Asound.conf file unchanged, so no further update is needed Dec 15 09:52:12 volumio volumio[8805]: info: Output device has changed, restarting MPD Dec 15 09:52:12 volumio bash[28283]: cset: --> shielding system active with Dec 15 09:52:12 volumio bash[28283]: cset: "system" cpuset of CPUSPEC(1-3) with 283 tasks running Dec 15 09:52:12 volumio bash[28283]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Dec 15 09:52:12 volumio volumio[8805]: info: Output device has changed, restarting Shairport Sync Dec 15 09:52:12 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:12 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:12 volumio systemd[1]: Finished musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 15 09:52:12 volumio sudo[28285]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 15 09:52:12 volumio sudo[28285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:12 volumio sudo[28285]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:12 volumio sudo[28288]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:13 volumio volumio[8805]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 15 09:52:13 volumio sudo[28288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio volumio[8805]: info: PLUGIN START: peppyspectrum Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 15 09:52:13 volumio systemd[1]: musicservicesshield.service: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 15 09:52:13 volumio systemd[1]: Stopping musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 15 09:52:13 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 15 09:52:13 volumio volumio[8805]: info: Preparing to generate the ALSA configuration file Dec 15 09:52:13 volumio sudo[28295]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 15 09:52:13 volumio sudo[28295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio volumio[8805]: info: Done. Dec 15 09:52:13 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:13 volumio systemd[1]: mpd.service: Consumed 1.577s CPU time. Dec 15 09:52:13 volumio sudo[28295]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:13 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:13 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:13 volumio volumio[8805]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 15 09:52:13 volumio volumio[8805]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 15 09:52:13 volumio volumio[8805]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:13 volumio volumio[8805]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 15 09:52:13 volumio volumio[8805]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 15 09:52:13 volumio volumio[8805]: info: Reading ALSA contributions from plugins. Dec 15 09:52:13 volumio sudo[28299]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:13 volumio volumio[8805]: info: snd_dummy loaded Dec 15 09:52:13 volumio volumio[8805]: info: MPD Permissions set Dec 15 09:52:13 volumio sudo[28299]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio sudo[28301]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:13 volumio sudo[28301]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio volumio[8805]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:13 volumio volumio[8805]: info: Starting Shairport Sync Dec 15 09:52:13 volumio volumio[8805]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::volumioGetState Dec 15 09:52:13 volumio volumio[8805]: info: CorePlayQueue::getTrack 0 Dec 15 09:52:13 volumio volumio[8805]: info: mpdhttpout --- Volumio set on pause Dec 15 09:52:13 volumio volumio[8805]: info: Asound.conf file unchanged, so no further update is needed Dec 15 09:52:13 volumio volumio[8805]: info: Output device has changed, restarting MPD Dec 15 09:52:13 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 15 09:52:13 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:13 volumio systemd[1]: mpd_monitor.service: Consumed 1.185s CPU time. Dec 15 09:52:13 volumio sudo[28311]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 15 09:52:13 volumio sudo[28311]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio volumio[8805]: info: Output device has changed, restarting Shairport Sync Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:13 volumio sudo[28313]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 15 09:52:13 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 15 09:52:13 volumio sudo[28313]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:13 volumio systemd[1]: shairport-sync.service: Consumed 1.222s CPU time. Dec 15 09:52:13 volumio sudo[28313]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:13 volumio volumio[8805]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 15 09:52:13 volumio sudo[28317]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:13 volumio sudo[28317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio sudo[28309]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:13 volumio sudo[28309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:13 volumio sudo[28309]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:13 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:13 volumio volumio[8805]: info: MPD Permissions set Dec 15 09:52:13 volumio sudo[28311]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:13 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:13 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 15 09:52:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:13 volumio volumio[8805]: info: Shairport-Sync Started Dec 15 09:52:13 volumio volumio[8805]: info: Starting Shairport Sync Dec 15 09:52:13 volumio volumio[8805]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Dec 15 09:52:13 volumio volumio[8805]: info: CoreCommandRouter::volumioGetState Dec 15 09:52:13 volumio volumio[8805]: info: CorePlayQueue::getTrack 0 Dec 15 09:52:13 volumio volumio[8805]: info: mpdhttpout --- Volumio set on pause Dec 15 09:52:13 volumio sudo[28351]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 15 09:52:13 volumio sudo[28351]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:13 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 15 09:52:13 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 15 09:52:13 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:13 volumio sudo[28348]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:13 volumio sudo[28348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:13 volumio sudo[28348]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:13 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 15 09:52:13 volumio sudo[28351]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:13 volumio volumio[8805]: info: Shairport-Sync Started Dec 15 09:52:15 volumio sudo[28371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:15 volumio sudo[28371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:15 volumio sudo[28373]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:15 volumio sudo[28373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:15 volumio mpd[28355]: 2025-12-15T09:52:15 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 15 09:52:15 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 15 09:52:15 volumio sudo[28317]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio sudo[28288]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio volumio[8805]: error: MPD error: The expression evaluated to a falsy value: Dec 15 09:52:15 volumio volumio[8805]: assert.ok(self.idling) Dec 15 09:52:15 volumio volumio[8805]: error: The expression evaluated to a falsy value: Dec 15 09:52:15 volumio volumio[8805]: assert.ok(self.idling) Dec 15 09:52:15 volumio volumio[8805]: error: updateQueue error: null Dec 15 09:52:15 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Dec 15 09:52:15 volumio sudo[28380]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:15 volumio sudo[28380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:15 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:15 volumio mpd_monitor.sh[28378]: MPD Monitor Service: Starting MPD Monitor Service Dec 15 09:52:15 volumio sudo[28299]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio sudo[28301]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio sudo[28373]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:15 volumio systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 15 09:52:15 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:15 volumio sudo[28371]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:15 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:15 volumio systemd[1]: musicservicesshield.service: Main process exited, code=killed, status=15/TERM Dec 15 09:52:15 volumio systemd[1]: musicservicesshield.service: Failed with result 'signal'. Dec 15 09:52:15 volumio systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 15 09:52:15 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 15 09:52:15 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:15 volumio systemd[1]: mpd.service: Consumed 1.726s CPU time. Dec 15 09:52:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:15 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Dec 15 09:52:15 volumio sudo[28397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 15 09:52:15 volumio sudo[28397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:15 volumio sudo[28395]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:15 volumio sudo[28395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:15 volumio sudo[28395]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:15 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 15 09:52:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 15 09:52:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 15 09:52:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 15 09:52:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 15 09:52:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 15 09:52:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 15 09:52:15 volumio sudo[28402]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 15 09:52:15 volumio sudo[28402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 15 09:52:15 volumio sudo[28402]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:17 volumio mpd[28404]: 2025-12-15T09:52:17 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 15 09:52:17 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 15 09:52:17 volumio sudo[28380]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:17 volumio sudo[28397]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:17 volumio volumio[8805]: error: MPD error: The expression evaluated to a falsy value: Dec 15 09:52:17 volumio volumio[8805]: assert.ok(self.idling) Dec 15 09:52:17 volumio volumio[8805]: error: The expression evaluated to a falsy value: Dec 15 09:52:17 volumio volumio[8805]: assert.ok(self.idling) Dec 15 09:52:17 volumio volumio[8805]: error: updateQueue error: null Dec 15 09:52:17 volumio systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 15 09:52:18 volumio bash[28421]: cset: --> shielding system active with Dec 15 09:52:18 volumio bash[28421]: cset: "system" cpuset of CPUSPEC(1-3) with 272 tasks running Dec 15 09:52:18 volumio bash[28421]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Dec 15 09:52:18 volumio systemd[1]: Finished musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 15 09:52:18 volumio sudo[28423]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:18 volumio sudo[28423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:18 volumio sudo[28425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:18 volumio sudo[28425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:18 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 15 09:52:18 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 15 09:52:18 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:18 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:18 volumio sudo[28425]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:18 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:18 volumio mpd_monitor.sh[28428]: MPD Monitor Service: Starting MPD Monitor Service Dec 15 09:52:18 volumio sudo[28423]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:18 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:20 volumio sudo[28447]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:20 volumio sudo[28447]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:20 volumio sudo[28449]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 15 09:52:20 volumio sudo[28449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:52:20 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 15 09:52:20 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 15 09:52:20 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:20 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:20 volumio sudo[28447]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:20 volumio mpd_monitor.sh[28452]: MPD Monitor Service: Starting MPD Monitor Service Dec 15 09:52:20 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:20 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 15 09:52:20 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 15 09:52:20 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:20 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 15 09:52:20 volumio sudo[28449]: pam_unix(sudo:session): session closed for user root Dec 15 09:52:20 volumio volumio[8805]: info: Successfully started MPD Monitor Dec 15 09:52:20 volumio mpd_monitor.sh[28454]: MPD Monitor Service: Starting MPD Monitor Service Dec 15 09:52:22 volumio go-librespot[9236]: time="2025-12-15T09:52:22+01:00" level=trace msg="sent dealer ping" Dec 15 09:52:22 volumio go-librespot[9236]: time="2025-12-15T09:52:22+01:00" level=trace msg="received dealer pong" Dec 15 09:52:23 volumio go-librespot[9236]: time="2025-12-15T09:52:23+01:00" level=trace msg="received accesspoint ping" Dec 15 09:52:23 volumio go-librespot[9236]: time="2025-12-15T09:52:23+01:00" level=trace msg="received accesspoint pong ack" Dec 15 09:52:26 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 15 09:52:26 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 15 09:52:41 volumio volumio[8805]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 15 09:52:52 volumio go-librespot[9236]: time="2025-12-15T09:52:52+01:00" level=trace msg="sent dealer ping" Dec 15 09:52:52 volumio go-librespot[9236]: time="2025-12-15T09:52:52+01:00" level=trace msg="received dealer pong" Dec 15 09:53:00 volumio volumio[8805]: info: CALLMETHOD: user_interface peppyspectrum savepeppy1 [object Object] Dec 15 09:53:00 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy1 Dec 15 09:53:00 volumio volumio[8805]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 15 09:53:00 volumio volumio[8805]: info: PeppySpectrum -----------------------spectrum Dec 15 09:53:00 volumio volumio[8805]: info: PeppySpectrum -----------------------$basefolder Dec 15 09:53:00 volumio volumio[8805]: info: PeppySpectrum -----------------------screensize320x240 Dec 15 09:53:00 volumio volumio[8805]: info: PeppySpectrum -----------------------screenwidth Dec 15 09:53:00 volumio volumio[8805]: info: PeppySpectrum -----------------------screenheight Dec 15 09:53:00 volumio volumio[8805]: info: PeppySpectrum -----------------------spectrumsize30 Dec 15 09:53:00 volumio volumio[8805]: error: PeppySpectrum ---Error writing config null Dec 15 09:53:00 volumio sudo[28528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppyspectrum.service Dec 15 09:53:00 volumio sudo[28528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:53:00 volumio volumio[8805]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 15 09:53:00 volumio volumio[8805]: info: CoreCommandRouter::Close All Modals sent Dec 15 09:53:00 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Dec 15 09:53:00 volumio sudo[28528]: pam_unix(sudo:session): session closed for user root Dec 15 09:53:00 volumio volumio[8805]: info: peppyspectrum Daemon Started Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:01 volumio startpeppyspectrum.sh[28531]: libpng warning: iCCP: known incorrect sRGB profile Dec 15 09:53:13 volumio volumio[8805]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Dec 15 09:53:13 volumio volumio[8805]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Dec 15 09:53:14 volumio volumio[8805]: --2025-12-15 09:53:13-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Dec 15 09:53:14 volumio volumio[8805]: Resolving github.com (github.com)... 140.82.121.3 Dec 15 09:53:14 volumio volumio[8805]: Connecting to github.com (github.com)|140.82.121.3|:443... connected. Dec 15 09:53:14 volumio volumio[8805]: HTTP request sent, awaiting response... 404 Not Found Dec 15 09:53:14 volumio volumio[8805]: 2025-12-15 09:53:14 ERROR 404: Not Found. Dec 15 09:53:14 volumio volumio[8805]: --2025-12-15 09:53:14-- http://a/ Dec 15 09:53:14 volumio volumio[8805]: Resolving a (a)... failed: Device or resource busy. Dec 15 09:53:14 volumio volumio[8805]: wget: unable to resolve host address ‘a’ Dec 15 09:53:14 volumio volumio[8805]: --2025-12-15 09:53:14-- http://packet.zip/ Dec 15 09:53:14 volumio volumio[8805]: Resolving packet.zip (packet.zip)... 162.255.119.167 Dec 15 09:53:14 volumio volumio[8805]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Dec 15 09:53:14 volumio volumio[8805]: HTTP request sent, awaiting response... 302 Found Dec 15 09:53:14 volumio volumio[8805]: Location: http://www.packet.zip/ [following] Dec 15 09:53:14 volumio volumio[8805]: --2025-12-15 09:53:14-- http://www.packet.zip/ Dec 15 09:53:14 volumio volumio[8805]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Dec 15 09:53:14 volumio volumio[8805]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Dec 15 09:53:14 volumio volumio[8805]: HTTP request sent, awaiting response... 403 Forbidden Dec 15 09:53:14 volumio volumio[8805]: 2025-12-15 09:53:14 ERROR 403: Forbidden. Dec 15 09:53:14 volumio volumio[8805]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Dec 15 09:53:14 volumio volumio[8805]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 15 09:53:14 volumio volumio[8805]: /bin/rm: cannot remove 'a': No such file or directory Dec 15 09:53:14 volumio volumio[8805]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 15 09:53:14 volumio volumio[8805]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 09:53:14 volumio volumio[8805]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Dec 15 09:53:14 volumio volumio[8805]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 15 09:53:14 volumio volumio[8805]: /bin/rm: cannot remove 'a': No such file or directory Dec 15 09:53:14 volumio volumio[8805]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 15 09:53:14 volumio volumio[8805]: at checkExecSyncError (node:child_process:887:11) Dec 15 09:53:14 volumio volumio[8805]: at execSync (node:child_process:959:15) Dec 15 09:53:14 volumio volumio[8805]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Dec 15 09:53:14 volumio volumio[8805]: at new Promise () Dec 15 09:53:14 volumio volumio[8805]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Dec 15 09:53:14 volumio volumio[8805]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 15 09:53:14 volumio volumio[8805]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Dec 15 09:53:14 volumio volumio[8805]: at Socket.emit (node:events:514:28) Dec 15 09:53:14 volumio volumio[8805]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 15 09:53:14 volumio volumio[8805]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Dec 15 09:53:14 volumio volumio[8805]: status: 1, Dec 15 09:53:14 volumio volumio[8805]: signal: null, Dec 15 09:53:14 volumio volumio[8805]: output: [ Dec 15 09:53:14 volumio volumio[8805]: null, Dec 15 09:53:14 volumio volumio[8805]: , Dec 15 09:53:14 volumio volumio[8805]: Dec 15 09:53:14 volumio volumio[8805]: ], Dec 15 09:53:14 volumio volumio[8805]: pid: 28562, Dec 15 09:53:14 volumio volumio[8805]: stdout: , Dec 15 09:53:14 volumio volumio[8805]: stderr: Dec 15 09:53:14 volumio volumio[8805]: } Dec 15 09:53:14 volumio volumio[8805]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 09:53:15 volumio sudo[28579]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-15 09:52' Dec 15 09:53:15 volumio sudo[28579]: 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"