Mar 27 20:35:08 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:35:08 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:35:18 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:35:18 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:35:18 volumio volumio[1239]: info: Listing playlists Mar 27 20:35:18 volumio volumio[1239]: info: Listing playlists Mar 27 20:35:28 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:35:28 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:35:38 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:35:38 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:35:38 volumio volumio[1239]: info: Listing playlists Mar 27 20:35:38 volumio volumio[1239]: info: Listing playlists Mar 27 20:35:41 volumio volumio[1239]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Mar 27 20:35:41 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:41.272+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:43 volumio volumio[1239]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Mar 27 20:35:43 volumio volumio[1239]: info: Folder /tmp/plugins removed Mar 27 20:35:43 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:43.973+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:45 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:45.398+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:45 volumio volumio[1239]: info: Check plugin dependencies Mar 27 20:35:45 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 27 20:35:45 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:45.504+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:45 volumio volumio[1239]: info: Checking if plugin already exists Mar 27 20:35:45 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:45.514+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:45 volumio volumio[1239]: info: Rename folder Mar 27 20:35:45 volumio volumio[1239]: info: Folder /tmp/downloaded_plugin.zip removed Mar 27 20:35:45 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:45.553+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:45 volumio volumio[1239]: info: Move to category Mar 27 20:35:48 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:48.688+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:48 volumio volumio[1239]: info: Checking if install.sh is present Mar 27 20:35:48 volumio volumio[1239]: info: Executing install.sh Mar 27 20:35:48 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:35:48 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:35:48 volumio sudo[3215]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/now_playing/install.sh Mar 27 20:35:48 volumio sudo[3215]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:35:48 volumio volumio[1239]: info: Installing geo-tz node dependency Mar 27 20:35:48 volumio volumio5-onboarding[1482]: time=2026-03-27T20:35:48.816+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:35:48 volumio su[3218]: (to volumio) root on none Mar 27 20:35:48 volumio su[3218]: pam_unix(su:session): session opened for user volumio(uid=1000) by (uid=0) Mar 27 20:35:49 volumio systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Mar 27 20:35:49 volumio systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Mar 27 20:35:49 volumio systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Mar 27 20:35:49 volumio systemd[1]: Starting user@1000.service - User Manager for UID 1000... Mar 27 20:35:49 volumio (systemd)[3220]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Mar 27 20:35:49 volumio systemd[3220]: Queued start job for default target default.target. Mar 27 20:35:49 volumio systemd[3220]: Created slice app.slice - User Application Slice. Mar 27 20:35:49 volumio systemd[3220]: Reached target paths.target - Paths. Mar 27 20:35:49 volumio systemd[3220]: Reached target timers.target - Timers. Mar 27 20:35:49 volumio systemd[3220]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Mar 27 20:35:49 volumio systemd[3220]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Mar 27 20:35:49 volumio systemd[3220]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Mar 27 20:35:49 volumio systemd[3220]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Mar 27 20:35:49 volumio systemd[3220]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Mar 27 20:35:49 volumio systemd[3220]: Reached target sockets.target - Sockets. Mar 27 20:35:49 volumio systemd[3220]: Reached target basic.target - Basic System. Mar 27 20:35:49 volumio systemd[1]: Started user@1000.service - User Manager for UID 1000. Mar 27 20:35:49 volumio systemd[3220]: Started mpris-proxy.service - Bluetooth mpris proxy. Mar 27 20:35:49 volumio systemd[3220]: Reached target default.target - Main User Target. Mar 27 20:35:49 volumio systemd[1]: Started session-c1.scope - Session c1 of User volumio. Mar 27 20:35:49 volumio systemd[3220]: Startup finished in 771ms. Mar 27 20:35:49 volumio mpris-proxy[3235]: Can't get on session bus Mar 27 20:35:49 volumio systemd[3220]: mpris-proxy.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:35:49 volumio systemd[3220]: mpris-proxy.service: Failed with result 'exit-code'. Mar 27 20:35:58 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:35:58 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:35:58 volumio volumio[1239]: info: Listing playlists Mar 27 20:35:58 volumio volumio[1239]: info: Listing playlists Mar 27 20:36:08 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:36:08 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:36:17 volumio volumio[1239]: info: Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.211+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: added 27 packages, changed 4 packages, and audited 162 packages in 25s Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.220+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.246+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: 24 packages are looking for funding Mar 27 20:36:17 volumio volumio[1239]: info: run `npm fund` for details Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.264+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.269+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.298+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: 4 vulnerabilities (1 low, 1 moderate, 2 high) Mar 27 20:36:17 volumio volumio[1239]: info: Mar 27 20:36:17 volumio volumio[1239]: info: To address all issues, run: Mar 27 20:36:17 volumio volumio[1239]: info: npm audit fix Mar 27 20:36:17 volumio volumio[1239]: info: Mar 27 20:36:17 volumio volumio[1239]: info: Run `npm audit` for details. Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.316+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.317+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.319+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.320+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.321+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.322+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio su[3218]: pam_unix(su:session): session closed for user volumio Mar 27 20:36:17 volumio systemd[1]: session-c1.scope: Deactivated successfully. Mar 27 20:36:17 volumio systemd[1]: session-c1.scope: Consumed 43.802s CPU time. Mar 27 20:36:17 volumio volumio[1239]: info: Creating user directories (if not exist) Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.386+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio sudo[3215]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:17 volumio volumio[1239]: info: Now Playing plugin installed Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.444+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: Plugin install end detected on script Mar 27 20:36:17 volumio volumio[1239]: info: Install script completed Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.458+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: Adding reference to registry Mar 27 20:36:17 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:17.471+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:17 volumio volumio[1239]: info: Done installing plugin. Mar 27 20:36:17 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 27 20:36:17 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 27 20:36:17 volumio volumio[1239]: info: Folder /tmp/plugins removed Mar 27 20:36:17 volumio volumio[1239]: info: Folder /tmp/downloaded_plugin.zip removed Mar 27 20:36:17 volumio volumio[1239]: info: Folder /data/temp removed Mar 27 20:36:18 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:36:18 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:36:18 volumio volumio[1239]: info: Listing playlists Mar 27 20:36:18 volumio volumio[1239]: info: Listing playlists Mar 27 20:36:21 volumio volumio[1239]: info: Enabling plugin now_playing Mar 27 20:36:21 volumio volumio[1239]: info: Loading plugin "now_playing"... Mar 27 20:36:23 volumio volumio[1239]: info: PLUGIN START: now_playing Mar 27 20:36:23 volumio volumio[1239]: info: [now-playing] ConfigUpdater: config version unavailable. Either this is the first time the plugin is installed, or the previous version is < 0.3.0). Config will not be updated. Mar 27 20:36:23 volumio volumio[1239]: info: [now-playing] ConfigUpdater: updated config version to 1.0.6 Mar 27 20:36:23 volumio volumio[1239]: info: [now-playing] App is listening on port 4004. Mar 27 20:36:23 volumio volumio[1239]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Mar 27 20:36:23 volumio volumio[1239]: info: Done. Mar 27 20:36:27 volumio systemd[1]: Stopping user@1000.service - User Manager for UID 1000... Mar 27 20:36:27 volumio systemd[3220]: Activating special unit exit.target... Mar 27 20:36:27 volumio systemd[3220]: Stopped target default.target - Main User Target. Mar 27 20:36:27 volumio systemd[3220]: Stopped target basic.target - Basic System. Mar 27 20:36:27 volumio systemd[3220]: Stopped target paths.target - Paths. Mar 27 20:36:27 volumio systemd[3220]: Stopped target sockets.target - Sockets. Mar 27 20:36:27 volumio systemd[3220]: Stopped target timers.target - Timers. Mar 27 20:36:27 volumio systemd[3220]: Closed dirmngr.socket - GnuPG network certificate management daemon. Mar 27 20:36:27 volumio systemd[3220]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Mar 27 20:36:27 volumio systemd[3220]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Mar 27 20:36:27 volumio systemd[3220]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Mar 27 20:36:27 volumio systemd[3220]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Mar 27 20:36:27 volumio systemd[3220]: Removed slice app.slice - User Application Slice. Mar 27 20:36:27 volumio systemd[3220]: Reached target shutdown.target - Shutdown. Mar 27 20:36:27 volumio systemd[3220]: Finished systemd-exit.service - Exit the Session. Mar 27 20:36:27 volumio systemd[3220]: Reached target exit.target - Exit the Session. Mar 27 20:36:27 volumio systemd[1]: user@1000.service: Deactivated successfully. Mar 27 20:36:27 volumio systemd[1]: Stopped user@1000.service - User Manager for UID 1000. Mar 27 20:36:27 volumio systemd[1]: Stopping user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Mar 27 20:36:27 volumio systemd[1]: run-user-1000.mount: Deactivated successfully. Mar 27 20:36:27 volumio systemd[1]: user-runtime-dir@1000.service: Deactivated successfully. Mar 27 20:36:27 volumio systemd[1]: Stopped user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Mar 27 20:36:27 volumio systemd[1]: Removed slice user-1000.slice - User Slice of UID 1000. Mar 27 20:36:27 volumio systemd[1]: user-1000.slice: Consumed 44.651s CPU time. Mar 27 20:36:28 volumio volumio[1239]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/bookworm/armhf Mar 27 20:36:28 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:28.332+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:28 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:36:28 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:36:30 volumio volumio[1239]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/bookworm/armhf Mar 27 20:36:30 volumio volumio[1239]: info: Folder /tmp/plugins removed Mar 27 20:36:30 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:30.756+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:31 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:31.301+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:31 volumio volumio[1239]: info: Check plugin dependencies Mar 27 20:36:31 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 27 20:36:31 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:31.350+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:31 volumio volumio[1239]: info: Checking if plugin already exists Mar 27 20:36:31 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:31.357+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:31 volumio volumio[1239]: info: Rename folder Mar 27 20:36:31 volumio volumio[1239]: info: Folder /tmp/downloaded_plugin.zip removed Mar 27 20:36:31 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:31.391+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:31 volumio volumio[1239]: info: Move to category Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.243+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: Checking if install.sh is present Mar 27 20:36:33 volumio volumio[1239]: info: Executing install.sh Mar 27 20:36:33 volumio sudo[3524]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Mar 27 20:36:33 volumio sudo[3524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:33 volumio volumio[1239]: info: creating filters folder and copying demo filters Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.300+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: copying demo flters Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.351+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/ Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.455+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/2XEQ15/ Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.462+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.481+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/PEQ/ Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.499+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.500+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.501+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.502+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.504+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio sudo[3549]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Mar 27 20:36:33 volumio sudo[3549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/convfir/ Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.542+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/convfir/kef.json Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.555+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/convfir/test.json Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.569+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/EQ15/ Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/EQ15/.Bass-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/EQ15/.Classic-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/EQ15/.Voice-FusionDsp.json Mar 27 20:36:33 volumio volumio[1239]: info: ./presets/EQ15/.Rock-FusionDsp.json Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.589+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.590+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: Installing/fusiondsp dependencies Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.645+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: Get:1 http://archive.raspberrypi.com/debian bookworm InRelease [55.0 kB] Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.892+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:33 volumio volumio[1239]: info: Get:2 http://raspbian.raspberrypi.com/raspbian bookworm InRelease [15.0 kB] Mar 27 20:36:33 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:33.965+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:34 volumio volumio[1239]: info: Get:3 http://archive.raspberrypi.com/debian bookworm/main armhf Packages [566 kB] Mar 27 20:36:34 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:34.404+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:34 volumio volumio[1239]: info: Get:4 http://archive.raspberrypi.com/debian bookworm/untested armhf Packages [1114 B] Mar 27 20:36:34 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:34.596+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:34 volumio volumio[1239]: info: Get:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf Packages [14.5 MB] Mar 27 20:36:34 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:34.849+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:36 volumio volumio[1239]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/contrib armhf Packages [62.3 kB] Mar 27 20:36:36 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:36.542+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.109+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Get:7 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages [118 kB] Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.166+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:7 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.308+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Get:8 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages [1360 B] Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.324+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:8 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.337+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.385+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:7 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.449+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:8 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.513+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Err:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.576+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Write error - write (28: No space left on device) Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.583+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:7 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.638+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Ign:8 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.700+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Fetched 15.3 MB in 4s (3898 kB/s) Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.717+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio volumio[1239]: info: Reading package lists... Mar 27 20:36:37 volumio sudo[3549]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:37 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:37.894+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:37 volumio sudo[3702]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install --no-install-recommends python3-venv drc Mar 27 20:36:37 volumio sudo[3702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:38 volumio volumio[1239]: info: Reading package lists... Mar 27 20:36:38 volumio sudo[3702]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:38 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:38.129+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:38 volumio volumio[1239]: info: creating sysytemd service Mar 27 20:36:38 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:38.150+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:38 volumio sudo[3710]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Mar 27 20:36:38 volumio sudo[3710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:38 volumio systemd[1]: Reloading. Mar 27 20:36:38 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:36:38 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:36:38 volumio volumio[1239]: info: Listing playlists Mar 27 20:36:38 volumio volumio[1239]: info: Listing playlists Mar 27 20:36:39 volumio sudo[3710]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:39 volumio volumio[1239]: info: copying hw detection script Mar 27 20:36:39 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:39.735+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:39 volumio volumio[1239]: info: Detected cpu architecture as armv7l Mar 27 20:36:39 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:39.825+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:40 volumio sudo[3789]: 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 Mar 27 20:36:40 volumio sudo[3789]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:40 volumio sudo[3789]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:40 volumio sudo[3791]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Mar 27 20:36:40 volumio sudo[3791]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:40 volumio sudo[3791]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:40 volumio volumio[1239]: info: Downloading camillagui ... Please wait! Mar 27 20:36:40 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:40.995+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:43 volumio volumio[1239]: info: Extracting camillagui ... Mar 27 20:36:43 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:43.078+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:43 volumio sudo[3524]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:43 volumio volumio[1239]: Plugin install end detected on script Mar 27 20:36:43 volumio volumio[1239]: info: Install script completed Mar 27 20:36:43 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:43.102+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:43 volumio volumio[1239]: info: Adding reference to registry Mar 27 20:36:43 volumio volumio5-onboarding[1482]: time=2026-03-27T20:36:43.111+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 27 20:36:43 volumio volumio[1239]: info: Done installing plugin. Mar 27 20:36:43 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 27 20:36:43 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 27 20:36:43 volumio volumio[1239]: info: Folder /tmp/plugins removed Mar 27 20:36:43 volumio volumio[1239]: info: Folder /tmp/downloaded_plugin.zip removed Mar 27 20:36:43 volumio volumio[1239]: info: Folder /data/temp removed Mar 27 20:36:46 volumio volumio[1239]: info: Enabling plugin fusiondsp Mar 27 20:36:46 volumio volumio[1239]: info: Loading plugin "fusiondsp"... Mar 27 20:36:47 volumio volumio[1239]: error: Could not copy default configuration to /data/configuration/audio_interface/fusiondsp/config.json Mar 27 20:36:47 volumio volumio[1239]: info: Preparing to generate the ALSA configuration file Mar 27 20:36:47 volumio volumio[1239]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 27 20:36:47 volumio volumio[1239]: info: Reading ALSA contributions from plugins. Mar 27 20:36:47 volumio volumio[1239]: info: Asound.conf file written Mar 27 20:36:47 volumio sudo[3815]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 27 20:36:47 volumio sudo[3815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:47 volumio sudo[3815]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:47 volumio volumio[1239]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Mar 27 20:36:47 volumio volumio[1239]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Mar 27 20:36:47 volumio volumio[1239]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Mar 27 20:36:47 volumio volumio[1239]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Mar 27 20:36:47 volumio volumio[1239]: No state is present for card sndrpihifiberry Mar 27 20:36:47 volumio volumio[1239]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Mar 27 20:36:47 volumio volumio[1239]: Found hardware: "RPi-simple" "" "" "" "" Mar 27 20:36:47 volumio volumio[1239]: Hardware is initialized using a generic method Mar 27 20:36:47 volumio volumio[1239]: No state is present for card sndrpihifiberry Mar 27 20:36:47 volumio volumio[1239]: info: Output device has changed, restarting MPD Mar 27 20:36:47 volumio volumio[1239]: info: Output device has changed, restarting Shairport Sync Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:36:47 volumio sudo[3823]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 27 20:36:47 volumio sudo[3823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:47 volumio sudo[3825]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 27 20:36:47 volumio sudo[3825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:47 volumio sudo[3823]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:47 volumio volumio[1239]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 27 20:36:47 volumio volumio[1239]: info: PLUGIN START: fusiondsp Mar 27 20:36:47 volumio volumio[1239]: info: FusionDsp - CamillaDSP binary found. Mar 27 20:36:47 volumio volumio[1239]: info: Loading i18n strings for locale de Mar 27 20:36:47 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: FusionDsp - mixtype--------------------- None Mar 27 20:36:47 volumio volumio[1239]: info: Preparing to generate the ALSA configuration file Mar 27 20:36:47 volumio volumio[1239]: info: Done. Mar 27 20:36:47 volumio volumio[1239]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 27 20:36:47 volumio volumio[1239]: info: Reading ALSA contributions from plugins. Mar 27 20:36:47 volumio volumio[1239]: info: MPD Permissions set Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 20:36:47 volumio systemd[1]: mpd.service: Deactivated successfully. Mar 27 20:36:47 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 27 20:36:47 volumio systemd[1]: mpd.service: Consumed 3.048s CPU time. Mar 27 20:36:47 volumio volumio[1239]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 27 20:36:47 volumio systemd[1]: mpd.socket: Deactivated successfully. Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 27 20:36:47 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Mar 27 20:36:47 volumio volumio[1239]: error: FusionDsp - failed to read local file for preset: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//undefined' Mar 27 20:36:47 volumio volumio[1239]: error: FusionDsp - Error: TypeError: Cannot read properties of undefined (reading 'split') Mar 27 20:36:47 volumio volumio[1239]: info: Starting Shairport Sync Mar 27 20:36:47 volumio sudo[3843]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 27 20:36:47 volumio volumio[1239]: info: Asound.conf file unchanged, so no further update is needed Mar 27 20:36:47 volumio volumio[1239]: info: Output device has changed, restarting MPD Mar 27 20:36:47 volumio sudo[3843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:47 volumio sudo[3841]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 27 20:36:47 volumio sudo[3841]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:47 volumio sudo[3841]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:47 volumio volumio[1239]: info: Output device has changed, restarting Shairport Sync Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:36:47 volumio volumio[1239]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 27 20:36:47 volumio sudo[3847]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 27 20:36:47 volumio sudo[3847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:48 volumio sudo[3851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 27 20:36:48 volumio sudo[3851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:48 volumio sudo[3847]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:48 volumio volumio[1239]: info: MPD Permissions set Mar 27 20:36:48 volumio volumio[1239]: info: Starting Shairport Sync Mar 27 20:36:48 volumio systemd[1]: mpd.service: Deactivated successfully. Mar 27 20:36:48 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 27 20:36:48 volumio systemd[1]: mpd.socket: Deactivated successfully. Mar 27 20:36:48 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 27 20:36:48 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 27 20:36:48 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 27 20:36:48 volumio sudo[3863]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 27 20:36:48 volumio sudo[3863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:48 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Mar 27 20:36:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 27 20:36:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 27 20:36:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 27 20:36:48 volumio systemd[1]: shairport-sync.service: Consumed 2.229s CPU time. Mar 27 20:36:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 27 20:36:48 volumio sudo[3843]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:48 volumio volumio[1239]: info: Shairport-Sync Started Mar 27 20:36:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 27 20:36:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 27 20:36:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 27 20:36:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 27 20:36:48 volumio sudo[3863]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:48 volumio volumio[1239]: info: Shairport-Sync Started Mar 27 20:36:48 volumio sudo[3865]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 27 20:36:48 volumio sudo[3865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 27 20:36:48 volumio sudo[3865]: pam_unix(sudo:session): session closed for user root Mar 27 20:36:48 volumio volumio[1239]: info: CoreCommandRouter::volumioGetState Mar 27 20:36:48 volumio volumio[1239]: info: CorePlayQueue::getTrack 0 Mar 27 20:36:48 volumio volumio[1239]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/audio_interface/fusiondsp/config.json' Mar 27 20:36:49 volumio volumio[1239]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 27 20:36:49 volumio volumio[1239]: error: Cannot read properties of undefined (reading 'toString') Mar 27 20:36:49 volumio volumio[1239]: info: camilladsp service started and running in background, instance 1 Mar 27 20:36:49 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:36:49 volumio volumio[1239]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent Mar 27 20:36:49 volumio volumio[1239]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 27 20:36:49 volumio volumio[1239]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent Mar 27 20:36:49 volumio volumio[1239]: info: FusionDsp loaded Mar 27 20:36:49 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 27 20:36:49 volumio volumio[1239]: info: FusionDsp - --[object Object] Mar 27 20:36:49 volumio volumio[1239]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 27 20:36:49 volumio volumio[1239]: info: Adding Signal Path Element [object Object] Mar 27 20:36:49 volumio volumio[1239]: info: Adding fusiondspeq DSP Signal Path Element Mar 27 20:36:49 volumio volumio[1239]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Mar 27 20:36:49 volumio volumio[1239]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 20:36:49 volumio volumio[1239]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES Mar 27 20:36:49 volumio volumio[1239]: at ChildProcess._handle.onexit (node:internal/child_process:286:19) Mar 27 20:36:49 volumio volumio[1239]: at onErrorNT (node:internal/child_process:484:16) Mar 27 20:36:49 volumio volumio[1239]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Mar 27 20:36:49 volumio volumio[1239]: errno: -13, Mar 27 20:36:49 volumio volumio[1239]: code: 'EACCES', Mar 27 20:36:49 volumio volumio[1239]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 27 20:36:49 volumio volumio[1239]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 27 20:36:49 volumio volumio[1239]: spawnargs: [ Mar 27 20:36:49 volumio volumio[1239]: '-p', Mar 27 20:36:49 volumio volumio[1239]: 9876, Mar 27 20:36:49 volumio volumio[1239]: '-o', Mar 27 20:36:49 volumio volumio[1239]: '/tmp/camilladsp.log', Mar 27 20:36:49 volumio volumio[1239]: '-l', Mar 27 20:36:49 volumio volumio[1239]: 'warn', Mar 27 20:36:49 volumio volumio[1239]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 27 20:36:49 volumio volumio[1239]: ] Mar 27 20:36:49 volumio volumio[1239]: } Mar 27 20:36:49 volumio volumio[1239]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 20:36:49 volumio sudo[3897]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 27 20:36:49 volumio sudo[3897]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:36:49 volumio systemd[1]: Starting fusiondsp.service - FusionDsp Daemon... Mar 27 20:36:50 volumio sudo[3914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-27 20:35' Mar 27 20:36:50 volumio sudo[3914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"