Feb 12 18:15:18 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState Feb 12 18:15:18 volumio volumio[1109]: info: CorePlayQueue::getTrack 1 Feb 12 18:15:21 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 12 18:15:21 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 12 18:15:30 volumio volumio[1109]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/bookworm/armhf Feb 12 18:15:32 volumio volumio[1109]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/bookworm/armhf Feb 12 18:15:32 volumio volumio[1109]: info: Folder /tmp/plugins removed Feb 12 18:15:33 volumio volumio[1109]: info: Check plugin dependencies Feb 12 18:15:33 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 12 18:15:33 volumio volumio[1109]: info: Checking if plugin already exists Feb 12 18:15:33 volumio volumio[1109]: info: Rename folder Feb 12 18:15:33 volumio volumio[1109]: info: Folder /tmp/downloaded_plugin.zip removed Feb 12 18:15:33 volumio volumio[1109]: info: Move to category Feb 12 18:15:34 volumio volumio[1109]: info: Checking if install.sh is present Feb 12 18:15:34 volumio volumio[1109]: info: Executing install.sh Feb 12 18:15:34 volumio sudo[11058]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Feb 12 18:15:34 volumio sudo[11058]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:15:34 volumio volumio[1109]: info: creating filters folder and copying demo filters Feb 12 18:15:34 volumio volumio[1109]: info: copying demo flters Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/ Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/2XEQ15/ Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/PEQ/ Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/convfir/ Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/convfir/kef.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/convfir/test.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/EQ15/ Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/EQ15/.Bass-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/EQ15/.Classic-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/EQ15/.Voice-FusionDsp.json Feb 12 18:15:34 volumio volumio[1109]: info: ./presets/EQ15/.Rock-FusionDsp.json Feb 12 18:15:34 volumio sudo[11085]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Feb 12 18:15:34 volumio sudo[11085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 18:15:34 volumio volumio[1109]: info: Installing/fusiondsp dependencies Feb 12 18:15:34 volumio volumio[1109]: info: Get:1 http://raspbian.raspberrypi.com/raspbian bookworm InRelease [15.0 kB] Feb 12 18:15:34 volumio volumio[1109]: info: Get:2 http://archive.raspberrypi.com/debian bookworm InRelease [54.9 kB] Feb 12 18:15:34 volumio volumio[1109]: info: Get:3 https://deb.nodesource.com/node_20.x nodistro InRelease [12.1 kB] Feb 12 18:15:35 volumio volumio[1109]: info: Get:4 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf Packages [14.5 MB] Feb 12 18:15:35 volumio volumio[1109]: info: Get:5 http://archive.raspberrypi.com/debian bookworm/main armhf Packages [563 kB] Feb 12 18:15:35 volumio volumio[1109]: info: Get:6 https://deb.nodesource.com/node_20.x nodistro/main armhf Packages [12.6 kB] Feb 12 18:15:36 volumio volumio[1109]: info: Get:7 http://archive.raspberrypi.com/debian bookworm/untested armhf Packages [1114 B] Feb 12 18:15:37 volumio volumio[1109]: info: Get:8 http://raspbian.raspberrypi.com/raspbian bookworm/contrib armhf Packages [62.3 kB] Feb 12 18:15:37 volumio volumio[1109]: info: Get:9 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages [118 kB] Feb 12 18:15:37 volumio volumio[1109]: info: Get:10 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages [1360 B] Feb 12 18:15:46 volumio volumio[1109]: info: Fetched 15.4 MB in 9s (1644 kB/s) Feb 12 18:15:54 volumio volumio[1109]: info: Reading package lists... Feb 12 18:15:55 volumio volumio[1109]: info: Building dependency tree... Feb 12 18:15:56 volumio volumio[1109]: info: Reading state information... Feb 12 18:15:56 volumio sudo[11085]: pam_unix(sudo:session): session closed for user root Feb 12 18:15:56 volumio volumio[1109]: info: 28 packages can be upgraded. Run 'apt list --upgradable' to see them. Feb 12 18:15:56 volumio sudo[11331]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install --no-install-recommends python3-venv drc Feb 12 18:15:56 volumio sudo[11331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 18:15:56 volumio volumio[1109]: info: Reading package lists... Feb 12 18:15:57 volumio volumio[1109]: info: Building dependency tree... Feb 12 18:15:57 volumio volumio[1109]: info: Reading state information... Feb 12 18:15:59 volumio volumio[1109]: info: The following additional packages will be installed: Feb 12 18:15:59 volumio volumio[1109]: info: python3-pip-whl python3-setuptools-whl python3.11-venv Feb 12 18:15:59 volumio volumio[1109]: info: The following NEW packages will be installed: Feb 12 18:15:59 volumio volumio[1109]: info: drc python3-pip-whl python3-setuptools-whl python3-venv python3.11-venv Feb 12 18:15:59 volumio volumio[1109]: info: 0 upgraded, 5 newly installed, 0 to remove and 28 not upgraded. Feb 12 18:15:59 volumio volumio[1109]: info: Need to get 2954 kB of archives. Feb 12 18:15:59 volumio volumio[1109]: info: After this operation, 3696 kB of additional disk space will be used. Feb 12 18:15:59 volumio volumio[1109]: info: Get:1 http://archive.raspberrypi.com/debian bookworm/main armhf python3-pip-whl all 23.0.1+dfsg-1+rpt1 [1718 kB] Feb 12 18:15:59 volumio volumio[1109]: info: Get:2 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf drc armhf 3.2.3~dfsg0-1 [118 kB] Feb 12 18:16:00 volumio volumio[1109]: info: Get:3 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3-setuptools-whl all 66.1.1-1+deb12u2 [1112 kB] Feb 12 18:16:00 volumio volumio[1109]: info: Get:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3-venv armhf 3.11.2-1 [1188 B] Feb 12 18:16:00 volumio volumio[1109]: info: Get:4 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3.11-venv armhf 3.11.2-6+deb12u6 [5896 B] Feb 12 18:16:01 volumio volumio[1109]: info: Fetched 2954 kB in 1s (4265 kB/s) Feb 12 18:16:01 volumio volumio[1109]: info: Selecting previously unselected package drc. Feb 12 18:16:03 volumio volumio[1109]: [620B blob data] Feb 12 18:16:03 volumio volumio[1109]: info: Preparing to unpack .../drc_3.2.3~dfsg0-1_armhf.deb ... Feb 12 18:16:03 volumio volumio[1109]: info: Unpacking drc (3.2.3~dfsg0-1) ... Feb 12 18:16:05 volumio volumio[1109]: info: Selecting previously unselected package python3-pip-whl. Feb 12 18:16:05 volumio volumio[1109]: info: Preparing to unpack .../python3-pip-whl_23.0.1+dfsg-1+rpt1_all.deb ... Feb 12 18:16:05 volumio volumio[1109]: info: Unpacking python3-pip-whl (23.0.1+dfsg-1+rpt1) ... Feb 12 18:16:06 volumio volumio[1109]: info: Selecting previously unselected package python3-setuptools-whl. Feb 12 18:16:06 volumio volumio[1109]: info: Preparing to unpack .../python3-setuptools-whl_66.1.1-1+deb12u2_all.deb ... Feb 12 18:16:06 volumio volumio[1109]: info: Unpacking python3-setuptools-whl (66.1.1-1+deb12u2) ... Feb 12 18:16:06 volumio volumio[1109]: info: Selecting previously unselected package python3.11-venv. Feb 12 18:16:06 volumio volumio[1109]: info: Preparing to unpack .../python3.11-venv_3.11.2-6+deb12u6_armhf.deb ... Feb 12 18:16:06 volumio volumio[1109]: info: Unpacking python3.11-venv (3.11.2-6+deb12u6) ... Feb 12 18:16:06 volumio volumio[1109]: info: Selecting previously unselected package python3-venv. Feb 12 18:16:06 volumio volumio[1109]: info: Preparing to unpack .../python3-venv_3.11.2-1_armhf.deb ... Feb 12 18:16:06 volumio volumio[1109]: info: Unpacking python3-venv (3.11.2-1) ... Feb 12 18:16:07 volumio volumio[1109]: info: Setting up drc (3.2.3~dfsg0-1) ... Feb 12 18:16:07 volumio volumio[1109]: info: Setting up python3-setuptools-whl (66.1.1-1+deb12u2) ... Feb 12 18:16:07 volumio volumio[1109]: info: Setting up python3-pip-whl (23.0.1+dfsg-1+rpt1) ... Feb 12 18:16:07 volumio volumio[1109]: info: Setting up python3.11-venv (3.11.2-6+deb12u6) ... Feb 12 18:16:07 volumio volumio[1109]: info: Setting up python3-venv (3.11.2-1) ... Feb 12 18:16:11 volumio sudo[11331]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:11 volumio volumio[1109]: info: creating sysytemd service Feb 12 18:16:11 volumio sudo[11481]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Feb 12 18:16:11 volumio sudo[11481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 18:16:11 volumio systemd[1]: Reloading. Feb 12 18:16:13 volumio sudo[11481]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:13 volumio volumio[1109]: info: copying hw detection script Feb 12 18:16:13 volumio volumio[1109]: info: Detected cpu architecture as armv7l Feb 12 18:16:14 volumio sudo[11517]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params Feb 12 18:16:14 volumio sudo[11517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 18:16:14 volumio sudo[11517]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:14 volumio sudo[11521]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Feb 12 18:16:14 volumio sudo[11521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 18:16:14 volumio sudo[11521]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:14 volumio volumio[1109]: info: Downloading camillagui ... Please wait! Feb 12 18:16:17 volumio volumio[1109]: info: Extracting camillagui ... Feb 12 18:16:21 volumio sudo[11058]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:21 volumio volumio[1109]: Plugin install end detected on script Feb 12 18:16:21 volumio volumio[1109]: info: Install script completed Feb 12 18:16:21 volumio volumio[1109]: info: Adding reference to registry Feb 12 18:16:21 volumio volumio[1109]: info: Done installing plugin. Feb 12 18:16:21 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 12 18:16:21 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 12 18:16:21 volumio volumio[1109]: info: Folder /tmp/plugins removed Feb 12 18:16:21 volumio volumio[1109]: info: Folder /tmp/downloaded_plugin.zip removed Feb 12 18:16:21 volumio volumio[1109]: info: Folder /data/temp removed Feb 12 18:16:25 volumio volumio[1109]: info: Enabling plugin fusiondsp Feb 12 18:16:25 volumio volumio[1109]: info: Loading plugin "fusiondsp"... Feb 12 18:16:28 volumio volumio[1109]: info: Preparing to generate the ALSA configuration file Feb 12 18:16:28 volumio volumio[1109]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 18:16:28 volumio volumio[1109]: info: Reading ALSA contributions from plugins. Feb 12 18:16:28 volumio volumio[1109]: Upnp client error: Error: This socket has been ended by the other party Feb 12 18:16:28 volumio volumio[1109]: info: Asound.conf file written Feb 12 18:16:28 volumio sudo[11583]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 12 18:16:28 volumio sudo[11583]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio sudo[11583]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:28 volumio volumio[1109]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 12 18:16:28 volumio volumio[1109]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 12 18:16:28 volumio volumio[1109]: info: Output device has changed, restarting MPD Feb 12 18:16:28 volumio volumio[1109]: info: Output device has changed, restarting Shairport Sync Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:28 volumio sudo[11589]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 18:16:28 volumio sudo[11589]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio sudo[11589]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:28 volumio sudo[11591]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 18:16:28 volumio sudo[11591]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 18:16:28 volumio volumio[1109]: info: PLUGIN START: fusiondsp Feb 12 18:16:28 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 12 18:16:28 volumio volumio[1109]: info: FusionDsp - CamillaDSP binary found. Feb 12 18:16:28 volumio volumio[1109]: info: Loading i18n strings for locale de Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: FusionDsp - mixtype--------------------- Hardware Feb 12 18:16:28 volumio volumio[1109]: info: Preparing to generate the ALSA configuration file Feb 12 18:16:28 volumio volumio[1109]: info: Done. Feb 12 18:16:28 volumio volumio[1109]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 18:16:28 volumio volumio[1109]: info: Reading ALSA contributions from plugins. Feb 12 18:16:28 volumio volumio[1109]: info: MPD Permissions set Feb 12 18:16:28 volumio volumio[1109]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 12 18:16:28 volumio volumio[1109]: info: Enabling plugin fusiondsp Feb 12 18:16:28 volumio volumio[1109]: info: Loading plugin "fusiondsp"... Feb 12 18:16:28 volumio volumio[1109]: info: Applying required configuration parameters for plugin fusiondsp Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: Asound.conf file unchanged, so no further update is needed Feb 12 18:16:28 volumio volumio[1109]: info: Output device has changed, restarting MPD Feb 12 18:16:28 volumio volumio[1109]: info: Output device has changed, restarting Shairport Sync Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:28 volumio sudo[11608]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 18:16:28 volumio sudo[11608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio sudo[11606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 18:16:28 volumio sudo[11606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio sudo[11606]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:28 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 18:16:28 volumio volumio[1109]: info: Preparing to generate the ALSA configuration file Feb 12 18:16:28 volumio volumio[1109]: info: Starting Shairport Sync Feb 12 18:16:28 volumio volumio[1109]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 18:16:28 volumio volumio[1109]: info: Reading ALSA contributions from plugins. Feb 12 18:16:28 volumio volumio[1109]: info: MPD Permissions set Feb 12 18:16:28 volumio sudo[11616]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 18:16:28 volumio sudo[11616]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: Starting Shairport Sync Feb 12 18:16:28 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 18:16:28 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 18:16:28 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:28 volumio systemd[1]: shairport-sync.service: Consumed 12.187s CPU time. Feb 12 18:16:28 volumio volumio[1109]: info: Asound.conf file unchanged, so no further update is needed Feb 12 18:16:28 volumio volumio[1109]: info: Output device has changed, restarting MPD Feb 12 18:16:28 volumio sudo[11624]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 18:16:28 volumio sudo[11624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:28 volumio volumio[1109]: info: Output device has changed, restarting Shairport Sync Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:28 volumio sudo[11616]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:28 volumio sudo[11628]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 18:16:28 volumio sudo[11628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio sudo[11628]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:28 volumio sudo[11630]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 18:16:28 volumio sudo[11630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:28 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 18:16:28 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 18:16:28 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:28 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 18:16:28 volumio volumio[1109]: info: PLUGIN START: fusiondsp Feb 12 18:16:28 volumio volumio[1109]: info: FusionDsp - CamillaDSP binary found. Feb 12 18:16:28 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:28 volumio volumio[1109]: info: Loading i18n strings for locale de Feb 12 18:16:28 volumio sudo[11624]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: FusionDsp - mixtype--------------------- Hardware Feb 12 18:16:28 volumio volumio[1109]: info: Preparing to generate the ALSA configuration file Feb 12 18:16:28 volumio volumio[1109]: info: Done. Feb 12 18:16:28 volumio volumio[1109]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 18:16:28 volumio volumio[1109]: info: Reading ALSA contributions from plugins. Feb 12 18:16:28 volumio volumio[1109]: info: MPD Permissions set Feb 12 18:16:28 volumio volumio[1109]: info: Shairport-Sync Started Feb 12 18:16:28 volumio volumio[1109]: info: Shairport-Sync Started Feb 12 18:16:28 volumio volumio[1109]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:28 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: Starting Shairport Sync Feb 12 18:16:29 volumio volumio[1109]: info: Asound.conf file unchanged, so no further update is needed Feb 12 18:16:29 volumio volumio[1109]: info: Output device has changed, restarting MPD Feb 12 18:16:29 volumio volumio[1109]: info: Output device has changed, restarting Shairport Sync Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:29 volumio sudo[11647]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 18:16:29 volumio sudo[11647]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:29 volumio sudo[11645]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 18:16:29 volumio sudo[11647]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:29 volumio sudo[11645]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:29 volumio sudo[11650]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 18:16:29 volumio sudo[11650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:29 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 18:16:29 volumio volumio[1109]: info: MPD Permissions set Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:29 volumio volumio[1109]: info: Starting Shairport Sync Feb 12 18:16:29 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 18:16:29 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 18:16:29 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:29 volumio sudo[11663]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 18:16:29 volumio sudo[11663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:29 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:29 volumio sudo[11645]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:29 volumio volumio[1109]: info: Shairport-Sync Started Feb 12 18:16:29 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 18:16:29 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 18:16:29 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:29 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 18:16:29 volumio sudo[11663]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:29 volumio volumio[1109]: info: Shairport-Sync Started Feb 12 18:16:30 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 12 18:16:30 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 12 18:16:30 volumio systemd[1]: mpd.service: Consumed 1min 27.013s CPU time. Feb 12 18:16:30 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 12 18:16:30 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 12 18:16:30 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 12 18:16:30 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 12 18:16:30 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 12 18:16:30 volumio sudo[11683]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 18:16:30 volumio sudo[11683]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 18:16:30 volumio sudo[11683]: pam_unix(sudo:session): session closed for user root Feb 12 18:16:30 volumio volumio[1109]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 12 18:16:30 volumio volumio[1109]: info: camilladsp service started and running in background, instance 1 Feb 12 18:16:30 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 18:16:30 volumio volumio[1109]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Feb 12 18:16:30 volumio volumio[1109]: info: FusionDsp loaded Feb 12 18:16:30 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 18:16:30 volumio volumio[1109]: info: FusionDsp - --[object Object] Feb 12 18:16:30 volumio volumio[1109]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 12 18:16:30 volumio volumio[1109]: info: Adding Signal Path Element [object Object] Feb 12 18:16:30 volumio volumio[1109]: info: Adding fusiondspeq DSP Signal Path Element Feb 12 18:16:30 volumio volumio[1109]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Feb 12 18:16:30 volumio volumio[1109]: error: FusionDsp - Reload WebSocket error: [object Object] Feb 12 18:16:30 volumio sudo[11700]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 12 18:16:30 volumio sudo[11700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 18:16:30 volumio volumio[1109]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 12 18:16:30 volumio volumio[1109]: TypeError: Cannot read properties of null (reading 'logger') Feb 12 18:16:30 volumio volumio[1109]: at SqueezeliteMCContext.getLogger (/data/plugins/music_service/squeezelite_mc/dist/lib/SqueezeliteMCContext.js:65:86) Feb 12 18:16:30 volumio volumio[1109]: at ControllerSqueezeliteMC._ControllerSqueezeliteMC_stdLogError (/data/plugins/music_service/squeezelite_mc/dist/index.js:716:36) Feb 12 18:16:30 volumio volumio[1109]: at /data/plugins/music_service/squeezelite_mc/dist/index.js:1216:121 Feb 12 18:16:30 volumio volumio[1109]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 12 18:16:30 volumio systemd[1]: Starting fusiondsp.service - FusionDsp Daemon... Feb 12 18:16:31 volumio sudo[11717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-12 18:15' Feb 12 18:16:31 volumio sudo[11717]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"