-- Logs begin at Thu 2019-02-14 11:12:07 CET, end at Sat 2025-11-01 23:44:01 CET. -- Nov 01 23:43:02 volumio sudo[6187]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:02 volumio volumio[756]: info: Install script completed Nov 01 23:43:03 volumio volumio[756]: info: Adding reference to registry Nov 01 23:43:03 volumio volumio[756]: info: Done installing plugin. Nov 01 23:43:03 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 23:43:03 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 01 23:43:03 volumio volumio[756]: info: Folder /tmp/plugins removed Nov 01 23:43:03 volumio volumio[756]: info: Folder /tmp/downloaded_plugin.zip removed Nov 01 23:43:03 volumio volumio[756]: info: Folder /data/temp removed Nov 01 23:43:08 volumio volumio[756]: info: Enabling plugin spop Nov 01 23:43:08 volumio volumio[756]: info: Loading plugin "spop"... Nov 01 23:43:16 volumio volumio[756]: info: PLUGIN START: spop Nov 01 23:43:17 volumio volumio[756]: info: Creating Spotify config file Nov 01 23:43:17 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:17 volumio volumio[756]: info: Done. Nov 01 23:43:17 volumio volumio[756]: info: Spotify config file written Nov 01 23:43:17 volumio volumio[756]: info: No need to fix Spotify hosts Nov 01 23:43:17 volumio sudo[6318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 01 23:43:17 volumio sudo[6318]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:17 volumio systemd[1]: Started go-librespot Daemon. Nov 01 23:43:17 volumio go-librespot[6320]: go-librespot daemon starting... Nov 01 23:43:17 volumio sudo[6318]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:17 volumio go-librespot[6320]: time="2025-11-01T23:43:17+01:00" level=info msg="running go-librespot 0.4.0" Nov 01 23:43:17 volumio go-librespot[6320]: time="2025-11-01T23:43:17+01:00" level=debug msg="no app state found" Nov 01 23:43:17 volumio go-librespot[6320]: time="2025-11-01T23:43:17+01:00" level=debug msg="stored credentials not found" Nov 01 23:43:17 volumio go-librespot[6320]: time="2025-11-01T23:43:17+01:00" level=info msg="generated new device id: 982684932c0fe7bb3f7c0daf04eed690634763c7" Nov 01 23:43:17 volumio go-librespot[6320]: time="2025-11-01T23:43:17+01:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 23:43:20 volumio go-librespot[6320]: time="2025-11-01T23:43:20+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 23:43:20 volumio go-librespot[6320]: time="2025-11-01T23:43:20+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 23:43:20 volumio go-librespot[6320]: time="2025-11-01T23:43:20+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 23:43:20 volumio go-librespot[6320]: time="2025-11-01T23:43:20+01:00" level=info msg="zeroconf server listening on port 38747" Nov 01 23:43:20 volumio volumio[756]: info: go-librespot daemon successfully initialized Nov 01 23:43:22 volumio volumio[756]: info: Enabling plugin fusiondsp Nov 01 23:43:22 volumio volumio[756]: info: Loading plugin "fusiondsp"... Nov 01 23:43:38 volumio nmbd[615]: [2025/11/01 23:43:33.162855, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 01 23:43:38 volumio nmbd[615]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.115 for name WORKGROUP<1d>. Nov 01 23:43:38 volumio nmbd[615]: This response was from IP 192.168.1.132, reporting an IP address of 192.168.1.132. Nov 01 23:43:43 volumio volumio[756]: info: Preparing to generate the ALSA configuration file Nov 01 23:43:43 volumio volumio[756]: info: Initializing connection to go-librespot Websocket Nov 01 23:43:43 volumio go-librespot[6320]: time="2025-11-01T23:43:43+01:00" level=debug msg="new websocket client" Nov 01 23:43:43 volumio volumio[756]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.144 UA: Mozilla/5.0 (Android 15; Mobile; rv:144.0) Gecko/144.0 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 5 Nov 01 23:43:43 volumio volumio[756]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.144 UA: Mozilla/5.0 (Android 15; Mobile; rv:144.0) Gecko/144.0 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 23:43:43 volumio volumio[756]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.144 UA: Mozilla/5.0 (Android 15; Mobile; rv:144.0) Gecko/144.0 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 7 Nov 01 23:43:43 volumio volumio[756]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.144 UA: Mozilla/5.0 (Android 15; Mobile; rv:144.0) Gecko/144.0 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 8 Nov 01 23:43:43 volumio volumio[756]: info: Reading package lists... Nov 01 23:43:44 volumio volumio[756]: info: Reading package lists... Nov 01 23:43:44 volumio volumio[756]: info: Connection to go-librespot Websocket established Nov 01 23:43:44 volumio volumio[756]: info: Asound.conf file unchanged, so no further update is needed Nov 01 23:43:44 volumio volumio[756]: info: Output device has changed, restarting MPD Nov 01 23:43:44 volumio volumio[756]: info: Output device has changed, restarting Shairport Sync Nov 01 23:43:44 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:44 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 23:43:44 volumio sudo[6404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 23:43:44 volumio sudo[6402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 23:43:44 volumio sudo[6402]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:44 volumio sudo[6404]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:44 volumio sudo[6402]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:44 volumio systemd[1]: Stopping Music Player Daemon... Nov 01 23:43:45 volumio volumio[756]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 23:43:45 volumio volumio[756]: info: PLUGIN START: fusiondsp Nov 01 23:43:45 volumio volumio[756]: info: Loading i18n strings for locale fr Nov 01 23:43:46 volumio sudo[5780]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:46 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 01 23:43:46 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:46 volumio volumio[756]: info: FusionDsp - mixtype--------------------- Hardware Nov 01 23:43:46 volumio volumio[756]: info: Preparing to generate the ALSA configuration file Nov 01 23:43:46 volumio sudo[6410]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Nov 01 23:43:46 volumio sudo[6410]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:46 volumio volumio[756]: info: Done. Nov 01 23:43:46 volumio volumio[756]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 01 23:43:46 volumio volumio[756]: info: Reading ALSA contributions from plugins. Nov 01 23:43:46 volumio volumio[756]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.144 UA: Mozilla/5.0 (Android 15; Mobile; rv:144.0) Gecko/144.0 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 8 Nov 01 23:43:46 volumio volumio[756]: info: MPD Permissions set Nov 01 23:43:46 volumio volumio[756]: info: Building dependency tree... Nov 01 23:43:46 volumio volumio[756]: info: Reading state information... Nov 01 23:43:46 volumio volumio[756]: info: All packages are up to date. Nov 01 23:43:46 volumio systemd[1]: mpd.service: Succeeded. Nov 01 23:43:46 volumio systemd[1]: Stopped Music Player Daemon. Nov 01 23:43:47 volumio volumio[756]: info: Building dependency tree... Nov 01 23:43:47 volumio systemd[1]: Starting Music Player Daemon... Nov 01 23:43:47 volumio volumio[756]: info: Reading state information... Nov 01 23:43:47 volumio volumio[756]: info: All packages are up to date. Nov 01 23:43:47 volumio sudo[6413]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 01 23:43:47 volumio sudo[6413]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:47 volumio sudo[6413]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:47 volumio volumio[756]: info: Getting Spotify volume Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 23:43:48 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:49 volumio volumio[756]: info: camilladsp service started and running in background, instance 1 Nov 01 23:43:49 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 23:43:49 volumio volumio[756]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 01 23:43:49 volumio volumio[756]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 01 23:43:49 volumio volumio[756]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 01 23:43:49 volumio volumio[756]: info: FusionDsp loaded Nov 01 23:43:49 volumio volumio[756]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 23:43:50 volumio sudo[6433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 01 23:43:50 volumio sudo[6433]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:50 volumio volumio[756]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 01 23:43:50 volumio volumio[756]: info: Adding Signal Path Element [object Object] Nov 01 23:43:50 volumio volumio[756]: info: Adding fusiondspeq DSP Signal Path Element Nov 01 23:43:50 volumio volumio[756]: info: FusionDsp - ---- installed callbackRead Nov 01 23:43:50 volumio volumio[756]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 23:43:50 volumio sudo[6433]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:50 volumio volumio[756]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 01 23:43:50 volumio volumio[756]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 01 23:43:50 volumio volumio[756]: at onErrorNT (internal/child_process.js:465:16) Nov 01 23:43:50 volumio volumio[756]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 01 23:43:50 volumio volumio[756]: at runNextTicks (internal/process/task_queues.js:62:3) Nov 01 23:43:50 volumio volumio[756]: at listOnTimeout (internal/timers.js:523:9) Nov 01 23:43:50 volumio volumio[756]: at processTimers (internal/timers.js:497:7) { Nov 01 23:43:50 volumio volumio[756]: errno: -2, Nov 01 23:43:50 volumio volumio[756]: code: 'ENOENT', Nov 01 23:43:50 volumio volumio[756]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 01 23:43:50 volumio volumio[756]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 01 23:43:50 volumio volumio[756]: spawnargs: [ Nov 01 23:43:50 volumio volumio[756]: '-p', Nov 01 23:43:50 volumio volumio[756]: 9876, Nov 01 23:43:50 volumio volumio[756]: '-o', Nov 01 23:43:50 volumio volumio[756]: '/tmp/camilladsp.log', Nov 01 23:43:50 volumio volumio[756]: '-l', Nov 01 23:43:50 volumio volumio[756]: 'warn', Nov 01 23:43:50 volumio volumio[756]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 01 23:43:50 volumio volumio[756]: ] Nov 01 23:43:50 volumio volumio[756]: } Nov 01 23:43:50 volumio volumio[756]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 23:43:58 volumio mpd_monitor.sh[482]: MPD Monitor Service: MPD Appears to be inactive, restarting Nov 01 23:43:58 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 01 23:43:58 volumio systemd[1]: mpd.service: Failed with result 'protocol'. Nov 01 23:43:58 volumio systemd[1]: Failed to start Music Player Daemon. Nov 01 23:43:58 volumio sudo[6404]: pam_unix(sudo:session): session closed for user root Nov 01 23:43:58 volumio systemd[1]: Starting Music Player Daemon... Nov 01 23:43:59 volumio sudo[6460]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 01 23:43:59 volumio sudo[6460]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 23:43:59 volumio sudo[6460]: pam_unix(sudo:session): session closed for user root Nov 01 23:44:01 volumio sudo[6464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-01 23:43 Nov 01 23:44:01 volumio sudo[6464]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"