-- Logs begin at Wed 2025-09-17 05:01:50 CEST, end at Wed 2025-09-17 20:28:11 CEST. --
Sep 17 20:27:00 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:00 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:00 raspberrypi volumio[31255]: info: FusionDsp -
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 20:27:00 raspberrypi volumio[31255]: info: FusionDsp - undefined
Sep 17 20:27:00 raspberrypi volumio[31255]: info: FusionDsp - undefined
Sep 17 20:27:00 raspberrypi volumio[31255]: info: FusionDsp - undefined
Sep 17 20:27:00 raspberrypi volumio[31255]: info: FusionDsp - undefined
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Output device has changed, restarting MPD
Sep 17 20:27:00 raspberrypi sudo[31381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:00 raspberrypi sudo[31381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:00 raspberrypi sudo[31381]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:00 raspberrypi sudo[31384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:00 raspberrypi sudo[31384]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:00 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:00 raspberrypi volumio[31255]: info: ___________ START PLUGINS ___________
Sep 17 20:27:00 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:00 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:00 raspberrypi volumio[31255]: info: ControllerMpd::onStart: Initializing MPD
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Creating MPD Configuration file
Sep 17 20:27:00 raspberrypi sudo[31391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:00 raspberrypi sudo[31391]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:00 raspberrypi volumio[31255]: info: [1758133620829] CoreMusicLibrary::Adding element Serwery Mediów
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:00 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:00 raspberrypi sudo[31391]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:00 raspberrypi sudo[31394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:00 raspberrypi sudo[31394]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:00 raspberrypi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 17 20:27:00 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:00 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:00 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:00 raspberrypi volumio[31255]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:00 raspberrypi volumio[31255]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:00 raspberrypi volumio[31255]: info: [1758133620999] CoreMusicLibrary::Adding element Last_100
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:01 raspberrypi volumio[31255]: info: [1758133621005] CoreMusicLibrary::Adding element Webradio
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Initializing BBC Radios
Sep 17 20:27:01 raspberrypi sudo[31396]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:01 raspberrypi sudo[31396]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:01 raspberrypi sudo[31396]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Creating Spotify config file
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Loading i18n strings for locale pl
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: FusionDsp - mixtype--------------------- Hardware
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Volumio Calling Home
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:01 raspberrypi volumio[31255]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:01 raspberrypi volumio[31255]: info: MPD Permissions set
Sep 17 20:27:01 raspberrypi volumio[31255]: info: MPD Permissions set
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Volumio called home
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Spotify config file written
Sep 17 20:27:01 raspberrypi sudo[31419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 17 20:27:01 raspberrypi sudo[31419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:01 raspberrypi systemd[1]: Stopping go-librespot Daemon...
Sep 17 20:27:01 raspberrypi volumio[31255]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:01 raspberrypi systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 17 20:27:01 raspberrypi systemd[1]: Stopped go-librespot Daemon.
Sep 17 20:27:01 raspberrypi systemd[1]: Started go-librespot Daemon.
Sep 17 20:27:01 raspberrypi go-librespot[31421]: go-librespot daemon starting...
Sep 17 20:27:01 raspberrypi sudo[31419]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=info msg="running go-librespot 0.3.2"
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=debug msg="app state loaded"
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=debug msg="stored credentials not found"
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:01 raspberrypi volumio[31255]: info: No need to fix Spotify hosts
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Starting Shairport Sync
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Starting Shairport Sync
Sep 17 20:27:01 raspberrypi sudo[31438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:01 raspberrypi volumio[31255]: info: Starting Shairport Sync
Sep 17 20:27:01 raspberrypi sudo[31438]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:01 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:01 raspberrypi go-librespot[31421]: time="2025-09-17T20:27:01+02:00" level=info msg="zeroconf server listening on port 43991"
Sep 17 20:27:01 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:01 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:01 raspberrypi sudo[31440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:01 raspberrypi sudo[31440]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:01 raspberrypi volumio[31255]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:01 raspberrypi sudo[31443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:01 raspberrypi sudo[31443]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:01 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:02 raspberrypi sudo[31438]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:02 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:02 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 32.
Sep 17 20:27:02 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:02 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:02 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:02 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:02 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Output device has changed, restarting MPD
Sep 17 20:27:02 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:02 raspberrypi sudo[31443]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:02 raspberrypi sudo[31440]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:02 raspberrypi sudo[31452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:02 raspberrypi sudo[31452]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:02 raspberrypi sudo[31454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:02 raspberrypi sudo[31454]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:02 raspberrypi sudo[31452]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:02 raspberrypi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:02 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:02 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Shairport-Sync Started
Sep 17 20:27:02 raspberrypi volumio[31255]: Error adding Membership: Error: addMembership EINVAL
Sep 17 20:27:02 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:02 raspberrypi volumio[31255]: info: MPD Permissions set
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Shairport-Sync Started
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Shairport-Sync Started
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Starting Shairport Sync
Sep 17 20:27:02 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:02 raspberrypi sudo[31468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:02 raspberrypi sudo[31468]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:02 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:02 raspberrypi sudo[31461]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:02 raspberrypi sudo[31461]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:02 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:02 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:02 raspberrypi sudo[31461]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:02 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:02 raspberrypi sudo[31468]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:02 raspberrypi volumio[31255]: info: Shairport-Sync Started
Sep 17 20:27:03 raspberrypi volumio[31255]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:03 raspberrypi volumio[31255]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 17 20:27:03 raspberrypi volumio[31255]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:03 raspberrypi volumio[31255]: info: camilladsp service started and running in background, instance 1
Sep 17 20:27:03 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:03 raspberrypi volumio[31255]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:03 raspberrypi volumio[31255]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Sep 17 20:27:03 raspberrypi volumio[31255]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:03 raspberrypi volumio[31255]: info: FusionDsp loaded
Sep 17 20:27:03 raspberrypi volumio[31255]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:03 raspberrypi sudo[31485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 17 20:27:03 raspberrypi sudo[31485]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:03 raspberrypi volumio[31255]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 17 20:27:03 raspberrypi volumio[31255]: info: Adding Signal Path Element [object Object]
Sep 17 20:27:03 raspberrypi volumio[31255]: info: Adding fusiondspeq DSP Signal Path Element
Sep 17 20:27:03 raspberrypi sudo[31485]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:03 raspberrypi volumio[31255]: info: FusionDsp - ---- installed callbackRead
Sep 17 20:27:03 raspberrypi volumio[31255]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:03 raspberrypi volumio[31255]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 17 20:27:03 raspberrypi volumio[31255]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 17 20:27:03 raspberrypi volumio[31255]: at onErrorNT (internal/child_process.js:465:16)
Sep 17 20:27:03 raspberrypi volumio[31255]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Sep 17 20:27:03 raspberrypi volumio[31255]: errno: -2,
Sep 17 20:27:03 raspberrypi volumio[31255]: code: 'ENOENT',
Sep 17 20:27:03 raspberrypi volumio[31255]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:03 raspberrypi volumio[31255]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:03 raspberrypi volumio[31255]: spawnargs: [
Sep 17 20:27:03 raspberrypi volumio[31255]: '-p',
Sep 17 20:27:03 raspberrypi volumio[31255]: 9876,
Sep 17 20:27:03 raspberrypi volumio[31255]: '-o',
Sep 17 20:27:03 raspberrypi volumio[31255]: '/tmp/camilladsp.log',
Sep 17 20:27:03 raspberrypi volumio[31255]: '-l',
Sep 17 20:27:03 raspberrypi volumio[31255]: 'warn',
Sep 17 20:27:03 raspberrypi volumio[31255]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 17 20:27:03 raspberrypi volumio[31255]: ]
Sep 17 20:27:03 raspberrypi volumio[31255]: }
Sep 17 20:27:03 raspberrypi volumio[31255]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:03 raspberrypi volumio[31448]: Traceback (most recent call last):
Sep 17 20:27:03 raspberrypi volumio[31448]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:03 raspberrypi volumio[31448]: from camilladsp import CamillaConnection
Sep 17 20:27:03 raspberrypi volumio[31448]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:03 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:03 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:04 raspberrypi sudo[31496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 20:26
Sep 17 20:27:04 raspberrypi sudo[31496]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:04 raspberrypi mpd[31472]: Sep 17 20:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 20:27:04 raspberrypi systemd[1]: Started Music Player Daemon.
Sep 17 20:27:04 raspberrypi sudo[31394]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:04 raspberrypi sudo[31384]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:04 raspberrypi sudo[31454]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:04 raspberrypi sudo[31496]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:04 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 17 20:27:04 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 17 20:27:04 raspberrypi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:04 raspberrypi systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 17 20:27:04 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:04 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:04 raspberrypi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 17 20:27:04 raspberrypi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 9.
Sep 17 20:27:04 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:04 raspberrypi systemd[1]: Stopped Volumio Backend Module.
Sep 17 20:27:04 raspberrypi systemd[1]: Started Volumio Backend Module.
Sep 17 20:27:04 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:05 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:05 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 33.
Sep 17 20:27:05 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:05 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:06 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:06 raspberrypi volumio[31523]: info: ----- Volumio3 ----
Sep 17 20:27:06 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:06 raspberrypi volumio[31523]: info: ----- System startup ----
Sep 17 20:27:06 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:06 raspberrypi volumio[31535]: Traceback (most recent call last):
Sep 17 20:27:06 raspberrypi volumio[31535]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:06 raspberrypi volumio[31535]: from camilladsp import CamillaConnection
Sep 17 20:27:06 raspberrypi volumio[31535]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:07 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:07 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:07 raspberrypi volumio[31523]: info: MYVOLUMIO Environment detected
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Plugin folders cleanup
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning into folder /volumio/app/plugins/
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category audio_interface
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category miscellanea
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category music_service
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category plugins.json
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category system_controller
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category user_interface
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning into folder /data/plugins/
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category audio_interface
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Scanning category music_service
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Plugin folders cleanup completed
Sep 17 20:27:07 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:07 raspberrypi volumio[31523]: info: ----- Core plugins startup ----
Sep 17 20:27:07 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Loading plugins from folder /volumio/app/plugins/
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Adding plugin upnp to MyMusic Plugins
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Loading plugins from folder /data/plugins/
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Loading plugin "system"...
Sep 17 20:27:07 raspberrypi volumio[31523]: info: Loading plugin "appearance"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "network"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Refreshing Cached IP Addresses
Sep 17 20:27:08 raspberrypi sudo[31550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 20:27:08 raspberrypi sudo[31550]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:08 raspberrypi sudo[31550]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:08 raspberrypi sudo[31552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 20:27:08 raspberrypi sudo[31552]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:08 raspberrypi sudo[31552]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "services"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "alsa_controller"...
Sep 17 20:27:08 raspberrypi sudo[31563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 17 20:27:08 raspberrypi sudo[31563]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:08 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "wizard"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "networkfs"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Starting Udev Watcher for removable devices
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Ignoring mount for partition: boot
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Ignoring mount for partition: volumio
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Ignoring mount for partition: volumio_data
Sep 17 20:27:08 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "volumio_command_line_client"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "upnp"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: [1758133628712] Starting Upmpd Daemon
Sep 17 20:27:08 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "my_music"...
Sep 17 20:27:08 raspberrypi volumio[31523]: info: Loading plugin "mpd"...
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "upnp_browser"...
Sep 17 20:27:09 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:09 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 34.
Sep 17 20:27:09 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:09 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:09 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:09] [connect] Successful connection
Sep 17 20:27:09 raspberrypi sudo[31563]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "alarm-clock"...
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "airplay_emulation"...
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Starting Shairport Sync
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "last_100"...
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "webradio"...
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "i2s_dacs"...
Sep 17 20:27:09 raspberrypi volumio[31523]: info: I2S DAC not set, start Auto-detection
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "volumiodiscovery"...
Sep 17 20:27:09 raspberrypi volumio[31523]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:09 raspberrypi volumio[31523]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:09 raspberrypi volumio[31523]: *** WARNING *** For more information see
Sep 17 20:27:09 raspberrypi node[31523]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:09 raspberrypi volumio[31523]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:09 raspberrypi volumio[31523]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:09 raspberrypi volumio[31523]: *** WARNING *** For more information see
Sep 17 20:27:09 raspberrypi node[31523]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:09 raspberrypi node[31523]: *** WARNING *** For more information see
Sep 17 20:27:09 raspberrypi node[31523]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:09 raspberrypi node[31523]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:09 raspberrypi node[31523]: *** WARNING *** For more information see
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Discovery: Started advertising with name: raspberrypi
Sep 17 20:27:09 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:09 raspberrypi volumio[31523]: info: Loading plugin "spop"...
Sep 17 20:27:10 raspberrypi volumio[31577]: Traceback (most recent call last):
Sep 17 20:27:10 raspberrypi volumio[31577]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:10 raspberrypi volumio[31577]: from camilladsp import CamillaConnection
Sep 17 20:27:10 raspberrypi volumio[31577]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:10 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:10 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "outputs"...
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "albumart"...
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Plugin example_plugin is not enabled
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "inputs"...
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "updater_comm"...
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Plugin mpdemulation is not enabled
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "rest_api"...
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "websocket"...
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Starting Socket.io Server version 2.3.0
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading plugin "fusiondsp"...
Sep 17 20:27:11 raspberrypi volumio[31523]: Forking 3 albumart workers
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Applying required configuration parameters for plugin fusiondsp
Sep 17 20:27:11 raspberrypi volumio[31523]: info: Loading i18n strings for locale pl
Sep 17 20:27:11 raspberrypi volumio[31523]: Updating browse sources language
Sep 17 20:27:11 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::initPlayerControls
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: Express server listening on port 3000
Sep 17 20:27:12 raspberrypi volumio[31523]: [Metrics] WebUI: 6s 192.83ms
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreStateMachine::resetVolumioState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreStateMachine::getcurrentVolume
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Volumio Network Manager: Network status updated: 3
Sep 17 20:27:12 raspberrypi volumio[31523]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 17 20:27:12 raspberrypi volumio[31523]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 17 20:27:12 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1758133629 101
Sep 17 20:27:12 raspberrypi volumio[31523]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3
Sep 17 20:27:12 raspberrypi volumio[31523]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 4
Sep 17 20:27:12 raspberrypi volumio[31523]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 17 20:27:12 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:12 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 35.
Sep 17 20:27:12 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:12 raspberrypi volumio[31523]: Starting albumart workers
Sep 17 20:27:12 raspberrypi volumio[31523]: Starting albumart workers
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Reloading queue from file
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Received Get System Info
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Discovery: Getting this device information
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetQueue
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreStateMachine::getQueue
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getQueue
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Listing playlists
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Received Get System Info
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:12 raspberrypi volumio[31523]: info: Discovery: Getting this device information
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: Starting albumart workers
Sep 17 20:27:12 raspberrypi volumio[31523]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreStateMachine::pushState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreStateMachine::updateTrackBlock
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CorePlayQueue::getTrackBlock
Sep 17 20:27:12 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Setting Device type: Raspberry PI
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreStateMachine::setRepeat false single undefined
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreStateMachine::pushState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreStateMachine::setRandom null
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreStateMachine::pushState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreStateMachine::pushState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Discovery: adding 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Discovery: Found device raspberrypi
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Completed loading Core Plugins
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Discovery: this is already registered, 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Discovery: Found device raspberrypi
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:13 raspberrypi volumio[31523]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Output device has changed, restarting MPD
Sep 17 20:27:13 raspberrypi sudo[31650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:13 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:13 raspberrypi sudo[31652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:13 raspberrypi sudo[31652]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:13 raspberrypi sudo[31650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:13 raspberrypi sudo[31650]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:13 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:27:13 raspberrypi volumio[31523]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:13 raspberrypi volumio[31523]: info: ___________ START PLUGINS ___________
Sep 17 20:27:13 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:13 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:14 raspberrypi volumio[31523]: info: ControllerMpd::onStart: Initializing MPD
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Creating MPD Configuration file
Sep 17 20:27:14 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:14 raspberrypi volumio[31523]: info: [1758133634051] CoreMusicLibrary::Adding element Serwery Mediów
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:14 raspberrypi sudo[31662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:14 raspberrypi sudo[31662]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:14 raspberrypi sudo[31660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:14 raspberrypi sudo[31660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:14 raspberrypi sudo[31660]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:14 raspberrypi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 17 20:27:14 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:14 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:14 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31616]: Traceback (most recent call last):
Sep 17 20:27:14 raspberrypi volumio[31616]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:14 raspberrypi volumio[31616]: from camilladsp import CamillaConnection
Sep 17 20:27:14 raspberrypi volumio[31616]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:14 raspberrypi volumio[31523]: info: [1758133634226] CoreMusicLibrary::Adding element Last_100
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:14 raspberrypi volumio[31523]: info: [1758133634231] CoreMusicLibrary::Adding element Webradio
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Initializing BBC Radios
Sep 17 20:27:14 raspberrypi sudo[31668]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:14 raspberrypi sudo[31668]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:14 raspberrypi sudo[31668]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Creating Spotify config file
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:14 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Loading i18n strings for locale pl
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: FusionDsp - mixtype--------------------- Hardware
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Volumio Calling Home
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:14 raspberrypi volumio[31523]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:14 raspberrypi volumio[31523]: info: MPD Permissions set
Sep 17 20:27:14 raspberrypi volumio[31523]: info: MPD Permissions set
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Spotify config file written
Sep 17 20:27:14 raspberrypi volumio[31523]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Sep 17 20:27:14 raspberrypi volumio[31523]: info: Volumio called home
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi sudo[31688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 17 20:27:14 raspberrypi sudo[31688]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:14 raspberrypi systemd[1]: Stopping go-librespot Daemon...
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:14 raspberrypi systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 17 20:27:14 raspberrypi systemd[1]: Stopped go-librespot Daemon.
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:14 raspberrypi volumio[31523]: info: No need to fix Spotify hosts
Sep 17 20:27:14 raspberrypi systemd[1]: Started go-librespot Daemon.
Sep 17 20:27:14 raspberrypi go-librespot[31694]: go-librespot daemon starting...
Sep 17 20:27:14 raspberrypi sudo[31688]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:14 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:14+02:00" level=info msg="running go-librespot 0.3.2"
Sep 17 20:27:14 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:14+02:00" level=debug msg="app state loaded"
Sep 17 20:27:14 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:14+02:00" level=debug msg="stored credentials not found"
Sep 17 20:27:14 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:14+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Sep 17 20:27:14 raspberrypi volumio[31523]: info: FusionDsp -
Sep 17 20:27:15 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:15+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]"
Sep 17 20:27:15 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:15+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Sep 17 20:27:15 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:15+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Sep 17 20:27:15 raspberrypi go-librespot[31694]: time="2025-09-17T20:27:15+02:00" level=info msg="zeroconf server listening on port 34987"
Sep 17 20:27:15 raspberrypi volumio[31523]: info: FusionDsp -
Sep 17 20:27:15 raspberrypi volumio[31523]: info: FusionDsp -
Sep 17 20:27:15 raspberrypi volumio[31523]: info: FusionDsp -
Sep 17 20:27:15 raspberrypi volumio[31523]: info: FusionDsp - undefined
Sep 17 20:27:15 raspberrypi mpd[31676]: Sep 17 20:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 20:27:16 raspberrypi volumio[31523]: info: FusionDsp - undefined
Sep 17 20:27:16 raspberrypi volumio[31523]: info: FusionDsp - undefined
Sep 17 20:27:16 raspberrypi systemd[1]: Started Music Player Daemon.
Sep 17 20:27:16 raspberrypi sudo[31662]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi sudo[31652]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi volumio[31523]: info: FusionDsp - undefined
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Starting Shairport Sync
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Starting Shairport Sync
Sep 17 20:27:16 raspberrypi sudo[31711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:16 raspberrypi sudo[31711]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Starting Shairport Sync
Sep 17 20:27:16 raspberrypi sudo[31714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:16 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:16 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:16 raspberrypi sudo[31714]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:16 raspberrypi volumio[31523]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:16 raspberrypi volumio[31523]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:16 raspberrypi sudo[31716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:16 raspberrypi sudo[31716]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Completed starting Core Plugins
Sep 17 20:27:16 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:16 raspberrypi volumio[31523]: info: ----- MyVolumio plugins startup ----
Sep 17 20:27:16 raspberrypi volumio[31523]: info: -------------------------------------------
Sep 17 20:27:16 raspberrypi volumio[31523]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 17 20:27:16 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:16 raspberrypi sudo[31711]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:16 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Output device has changed, restarting MPD
Sep 17 20:27:16 raspberrypi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:16 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:16 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:16 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:16 raspberrypi sudo[31714]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:16 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 36.
Sep 17 20:27:16 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:16 raspberrypi sudo[31716]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi sudo[31724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:16 raspberrypi sudo[31724]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:16 raspberrypi sudo[31724]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:16 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:16 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:16 raspberrypi sudo[31728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:16 raspberrypi sudo[31728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:16 raspberrypi volumio[31523]: error: MPD error: Error: write EPIPE
Sep 17 20:27:16 raspberrypi volumio[31523]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Sep 17 20:27:16 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:16 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:16 raspberrypi volumio[31523]: error: MPD error: The expression evaluated to a falsy value:
Sep 17 20:27:16 raspberrypi volumio[31523]: assert.ok(self.idling)
Sep 17 20:27:16 raspberrypi volumio[31523]: error: The expression evaluated to a falsy value:
Sep 17 20:27:16 raspberrypi volumio[31523]: assert.ok(self.idling)
Sep 17 20:27:16 raspberrypi volumio[31523]: error: MPD error: Error: write EPIPE
Sep 17 20:27:16 raspberrypi volumio[31523]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Sep 17 20:27:16 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:16 raspberrypi volumio[31523]: info: MPD running with PID31676
Sep 17 20:27:16 raspberrypi volumio[31523]: ,establishing connection
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Shairport-Sync Started
Sep 17 20:27:16 raspberrypi volumio[31523]: Error adding Membership: Error: addMembership EINVAL
Sep 17 20:27:16 raspberrypi volumio[31523]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:16 raspberrypi volumio[31523]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 17 20:27:16 raspberrypi volumio[31523]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:16 raspberrypi volumio[31523]: info: camilladsp service started and running in background, instance 1
Sep 17 20:27:16 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:16 raspberrypi volumio[31523]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:16 raspberrypi volumio[31523]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Sep 17 20:27:16 raspberrypi volumio[31523]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:16 raspberrypi volumio[31523]: info: FusionDsp loaded
Sep 17 20:27:16 raspberrypi volumio[31523]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:16 raspberrypi sudo[31735]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:16 raspberrypi sudo[31735]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi sudo[31735]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:16 raspberrypi sudo[31746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 17 20:27:16 raspberrypi sudo[31746]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:16 raspberrypi volumio[31523]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Adding Signal Path Element [object Object]
Sep 17 20:27:16 raspberrypi volumio[31523]: info: Adding fusiondspeq DSP Signal Path Element
Sep 17 20:27:16 raspberrypi volumio[31523]: info: FusionDsp - ---- installed callbackRead
Sep 17 20:27:16 raspberrypi volumio[31523]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:16 raspberrypi volumio[31523]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 17 20:27:16 raspberrypi volumio[31523]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 17 20:27:16 raspberrypi volumio[31523]: at onErrorNT (internal/child_process.js:465:16)
Sep 17 20:27:16 raspberrypi volumio[31523]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 17 20:27:16 raspberrypi volumio[31523]: at runNextTicks (internal/process/task_queues.js:62:3)
Sep 17 20:27:16 raspberrypi volumio[31523]: at listOnTimeout (internal/timers.js:523:9)
Sep 17 20:27:16 raspberrypi volumio[31523]: at processTimers (internal/timers.js:497:7) {
Sep 17 20:27:16 raspberrypi volumio[31523]: errno: -2,
Sep 17 20:27:16 raspberrypi volumio[31523]: code: 'ENOENT',
Sep 17 20:27:16 raspberrypi volumio[31523]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:16 raspberrypi volumio[31523]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:16 raspberrypi volumio[31523]: spawnargs: [
Sep 17 20:27:16 raspberrypi volumio[31523]: '-p',
Sep 17 20:27:16 raspberrypi volumio[31523]: 9876,
Sep 17 20:27:16 raspberrypi volumio[31523]: '-o',
Sep 17 20:27:16 raspberrypi volumio[31523]: '/tmp/camilladsp.log',
Sep 17 20:27:16 raspberrypi volumio[31523]: '-l',
Sep 17 20:27:16 raspberrypi volumio[31523]: 'warn',
Sep 17 20:27:16 raspberrypi volumio[31523]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 17 20:27:16 raspberrypi volumio[31523]: ]
Sep 17 20:27:16 raspberrypi volumio[31523]: }
Sep 17 20:27:16 raspberrypi volumio[31523]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:16 raspberrypi sudo[31746]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:17 raspberrypi sudo[31759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 20:26
Sep 17 20:27:17 raspberrypi sudo[31759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:17 raspberrypi volumio[31726]: Traceback (most recent call last):
Sep 17 20:27:17 raspberrypi volumio[31726]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:17 raspberrypi volumio[31726]: from camilladsp import CamillaConnection
Sep 17 20:27:17 raspberrypi volumio[31726]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:17 raspberrypi sudo[31759]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:17 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:17] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 17 20:27:17 raspberrypi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:17 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:17] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 17 20:27:17 raspberrypi sudo[31728]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:17 raspberrypi systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 17 20:27:17 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:17 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:17 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:17 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:18 raspberrypi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 17 20:27:18 raspberrypi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 10.
Sep 17 20:27:18 raspberrypi systemd[1]: Stopped Volumio Backend Module.
Sep 17 20:27:18 raspberrypi systemd[1]: Started Volumio Backend Module.
Sep 17 20:27:18 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:18 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:18 raspberrypi mpd[31749]: Sep 17 20:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 20:27:18 raspberrypi systemd[1]: Started Music Player Daemon.
Sep 17 20:27:19 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:19 raspberrypi volumio[31769]: info: ----- Volumio3 ----
Sep 17 20:27:19 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:19 raspberrypi volumio[31769]: info: ----- System startup ----
Sep 17 20:27:19 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:20 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:20 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 37.
Sep 17 20:27:20 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:20 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:20 raspberrypi volumio[31769]: info: MYVOLUMIO Environment detected
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Plugin folders cleanup
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning into folder /volumio/app/plugins/
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category audio_interface
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category miscellanea
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category music_service
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category plugins.json
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category system_controller
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category user_interface
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning into folder /data/plugins/
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category audio_interface
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Scanning category music_service
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Plugin folders cleanup completed
Sep 17 20:27:20 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:20 raspberrypi volumio[31769]: info: ----- Core plugins startup ----
Sep 17 20:27:20 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Loading plugins from folder /volumio/app/plugins/
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Adding plugin upnp to MyMusic Plugins
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Loading plugins from folder /data/plugins/
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Loading plugin "system"...
Sep 17 20:27:20 raspberrypi volumio[31769]: info: Loading plugin "appearance"...
Sep 17 20:27:21 raspberrypi volumio[31793]: Traceback (most recent call last):
Sep 17 20:27:21 raspberrypi volumio[31793]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:21 raspberrypi volumio[31793]: from camilladsp import CamillaConnection
Sep 17 20:27:21 raspberrypi volumio[31793]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:21 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:21 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "network"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Refreshing Cached IP Addresses
Sep 17 20:27:22 raspberrypi sudo[31800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 20:27:22 raspberrypi sudo[31800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:22 raspberrypi sudo[31800]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:22 raspberrypi sudo[31802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 20:27:22 raspberrypi sudo[31802]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:22 raspberrypi sudo[31802]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "services"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "alsa_controller"...
Sep 17 20:27:22 raspberrypi sudo[31811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 17 20:27:22 raspberrypi sudo[31811]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:22 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "wizard"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "networkfs"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Starting Udev Watcher for removable devices
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Ignoring mount for partition: boot
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Ignoring mount for partition: volumio
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Ignoring mount for partition: volumio_data
Sep 17 20:27:22 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "volumio_command_line_client"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "upnp"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: [1758133642300] Starting Upmpd Daemon
Sep 17 20:27:22 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "my_music"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "mpd"...
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "upnp_browser"...
Sep 17 20:27:22 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:22] [connect] Successful connection
Sep 17 20:27:22 raspberrypi volumio[31769]: info: Loading plugin "alarm-clock"...
Sep 17 20:27:22 raspberrypi sudo[31811]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Loading plugin "airplay_emulation"...
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Starting Shairport Sync
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Loading plugin "last_100"...
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Loading plugin "webradio"...
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Loading plugin "i2s_dacs"...
Sep 17 20:27:23 raspberrypi volumio[31769]: info: I2S DAC not set, start Auto-detection
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Loading plugin "volumiodiscovery"...
Sep 17 20:27:23 raspberrypi volumio[31769]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:23 raspberrypi volumio[31769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:23 raspberrypi volumio[31769]: *** WARNING *** For more information see
Sep 17 20:27:23 raspberrypi node[31769]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:23 raspberrypi volumio[31769]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:23 raspberrypi volumio[31769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:23 raspberrypi volumio[31769]: *** WARNING *** For more information see
Sep 17 20:27:23 raspberrypi node[31769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:23 raspberrypi node[31769]: *** WARNING *** For more information see
Sep 17 20:27:23 raspberrypi node[31769]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:23 raspberrypi node[31769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:23 raspberrypi node[31769]: *** WARNING *** For more information see
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Discovery: Started advertising with name: raspberrypi
Sep 17 20:27:23 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:23 raspberrypi volumio[31769]: info: Loading plugin "spop"...
Sep 17 20:27:23 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:23 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 38.
Sep 17 20:27:23 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:23 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "outputs"...
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "albumart"...
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Plugin example_plugin is not enabled
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "inputs"...
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "updater_comm"...
Sep 17 20:27:24 raspberrypi volumio[31829]: Traceback (most recent call last):
Sep 17 20:27:24 raspberrypi volumio[31829]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:24 raspberrypi volumio[31829]: from camilladsp import CamillaConnection
Sep 17 20:27:24 raspberrypi volumio[31829]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Plugin mpdemulation is not enabled
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "rest_api"...
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "websocket"...
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Starting Socket.io Server version 2.3.0
Sep 17 20:27:24 raspberrypi volumio[31769]: info: Loading plugin "fusiondsp"...
Sep 17 20:27:25 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:25 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:25 raspberrypi volumio[31769]: Forking 3 albumart workers
Sep 17 20:27:25 raspberrypi volumio[31769]: info: Applying required configuration parameters for plugin fusiondsp
Sep 17 20:27:25 raspberrypi volumio[31769]: info: Loading i18n strings for locale pl
Sep 17 20:27:25 raspberrypi volumio[31769]: Updating browse sources language
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::initPlayerControls
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: Express server listening on port 3000
Sep 17 20:27:25 raspberrypi volumio[31769]: [Metrics] WebUI: 6s 307.71ms
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreStateMachine::resetVolumioState
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreStateMachine::getcurrentVolume
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:25 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:25 raspberrypi volumio[31769]: info: Volumio Network Manager: Network status updated: 3
Sep 17 20:27:26 raspberrypi volumio[31769]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 17 20:27:26 raspberrypi volumio[31769]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 17 20:27:26 raspberrypi volumio[31769]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 3
Sep 17 20:27:26 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1758133642 101
Sep 17 20:27:26 raspberrypi volumio[31769]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4
Sep 17 20:27:26 raspberrypi volumio[31769]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 17 20:27:26 raspberrypi volumio[31769]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 6
Sep 17 20:27:26 raspberrypi volumio[31769]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::pushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::updateTrackBlock
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrackBlock
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:26 raspberrypi volumio[31769]: Starting albumart workers
Sep 17 20:27:26 raspberrypi volumio[31769]: Starting albumart workers
Sep 17 20:27:26 raspberrypi volumio[31769]: Starting albumart workers
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Reloading queue from file
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::setRepeat false single undefined
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::pushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::setRandom null
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::pushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Setting Device type: Raspberry PI
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Listing playlists
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Listing playlists
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Received Get System Info
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Discovery: Getting this device information
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetQueue
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::getQueue
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getQueue
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Listing playlists
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Received Get System Info
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Discovery: Getting this device information
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreStateMachine::pushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Discovery: adding 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Discovery: Found device raspberrypi
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:26 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Completed loading Core Plugins
Sep 17 20:27:26 raspberrypi volumio[31769]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Discovery: this is already registered, 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Discovery: Found device raspberrypi
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:27 raspberrypi volumio[31769]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Output device has changed, restarting MPD
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:27 raspberrypi sudo[31888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:27 raspberrypi sudo[31888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:27 raspberrypi sudo[31888]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:27 raspberrypi sudo[31894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:27 raspberrypi sudo[31894]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:27 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:27 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 39.
Sep 17 20:27:27 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:27 raspberrypi volumio[31769]: info: ___________ START PLUGINS ___________
Sep 17 20:27:27 raspberrypi volumio[31769]: info: ControllerMpd::onStart: Initializing MPD
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Creating MPD Configuration file
Sep 17 20:27:27 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:27 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:27 raspberrypi sudo[31908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:27 raspberrypi sudo[31908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:27 raspberrypi volumio[31769]: info: [1758133647331] CoreMusicLibrary::Adding element Serwery Mediów
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:27 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:27 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:27 raspberrypi sudo[31906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:27 raspberrypi sudo[31906]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:27 raspberrypi sudo[31906]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:27 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:27 raspberrypi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 17 20:27:27 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:27 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:27 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:27 raspberrypi volumio[31769]: info: [1758133647526] CoreMusicLibrary::Adding element Last_100
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:27 raspberrypi volumio[31769]: info: [1758133647533] CoreMusicLibrary::Adding element Webradio
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Initializing BBC Radios
Sep 17 20:27:27 raspberrypi sudo[31915]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:27 raspberrypi sudo[31915]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:27 raspberrypi sudo[31915]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Creating Spotify config file
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Loading i18n strings for locale pl
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:27 raspberrypi volumio[31769]: info: FusionDsp - mixtype--------------------- Hardware
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Volumio Calling Home
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 20:27:27 raspberrypi volumio[31769]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:27 raspberrypi volumio[31769]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:27 raspberrypi volumio[31769]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:27 raspberrypi volumio[31769]: info: MPD Permissions set
Sep 17 20:27:28 raspberrypi volumio[31769]: info: MPD Permissions set
Sep 17 20:27:28 raspberrypi volumio[31769]: info: Spotify config file written
Sep 17 20:27:28 raspberrypi sudo[31935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 17 20:27:28 raspberrypi volumio[31769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Sep 17 20:27:28 raspberrypi sudo[31935]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:28 raspberrypi volumio[31769]: info: Volumio called home
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi systemd[1]: Stopping go-librespot Daemon...
Sep 17 20:27:28 raspberrypi systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:28 raspberrypi systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 17 20:27:28 raspberrypi systemd[1]: Stopped go-librespot Daemon.
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi systemd[1]: Started go-librespot Daemon.
Sep 17 20:27:28 raspberrypi go-librespot[31941]: go-librespot daemon starting...
Sep 17 20:27:28 raspberrypi sudo[31935]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=info msg="running go-librespot 0.3.2"
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=debug msg="app state loaded"
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=debug msg="stored credentials not found"
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:28 raspberrypi volumio[31769]: info: No need to fix Spotify hosts
Sep 17 20:27:28 raspberrypi volumio[31769]: info: FusionDsp -
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Sep 17 20:27:28 raspberrypi go-librespot[31941]: time="2025-09-17T20:27:28+02:00" level=info msg="zeroconf server listening on port 34823"
Sep 17 20:27:28 raspberrypi volumio[31769]: info: FusionDsp -
Sep 17 20:27:28 raspberrypi volumio[31904]: Traceback (most recent call last):
Sep 17 20:27:28 raspberrypi volumio[31904]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:28 raspberrypi volumio[31904]: from camilladsp import CamillaConnection
Sep 17 20:27:28 raspberrypi volumio[31904]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:28 raspberrypi volumio[31769]: info: FusionDsp -
Sep 17 20:27:28 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:28 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp -
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp - undefined
Sep 17 20:27:29 raspberrypi mpd[31926]: Sep 17 20:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp - undefined
Sep 17 20:27:29 raspberrypi systemd[1]: Started Music Player Daemon.
Sep 17 20:27:29 raspberrypi sudo[31894]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:29 raspberrypi sudo[31908]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp - undefined
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp - undefined
Sep 17 20:27:29 raspberrypi volumio[31769]: info: Starting Shairport Sync
Sep 17 20:27:29 raspberrypi volumio[31769]: info: Starting Shairport Sync
Sep 17 20:27:29 raspberrypi sudo[31957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:29 raspberrypi sudo[31957]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:29 raspberrypi volumio[31769]: info: Starting Shairport Sync
Sep 17 20:27:29 raspberrypi sudo[31960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:29 raspberrypi sudo[31960]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:29 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:29 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:29 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:29 raspberrypi sudo[31963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:29 raspberrypi sudo[31963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:29 raspberrypi volumio[31769]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:29 raspberrypi volumio[31769]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:29 raspberrypi volumio[31769]: info: Completed starting Core Plugins
Sep 17 20:27:29 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:29 raspberrypi volumio[31769]: info: ----- MyVolumio plugins startup ----
Sep 17 20:27:29 raspberrypi volumio[31769]: info: -------------------------------------------
Sep 17 20:27:29 raspberrypi volumio[31769]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 17 20:27:29 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:29 raspberrypi sudo[31957]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:29 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:29 raspberrypi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:29 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:29 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:29 raspberrypi volumio[31769]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:29 raspberrypi volumio[31769]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 17 20:27:29 raspberrypi volumio[31769]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:29 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:29 raspberrypi sudo[31960]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:29 raspberrypi sudo[31963]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:29 raspberrypi volumio[31769]: info: camilladsp service started and running in background, instance 1
Sep 17 20:27:29 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:29 raspberrypi volumio[31769]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:29 raspberrypi volumio[31769]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Sep 17 20:27:29 raspberrypi volumio[31769]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp loaded
Sep 17 20:27:29 raspberrypi volumio[31769]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:29 raspberrypi sudo[31981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 17 20:27:29 raspberrypi sudo[31981]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 17 20:27:29 raspberrypi volumio[31769]: info: Adding Signal Path Element [object Object]
Sep 17 20:27:29 raspberrypi volumio[31769]: info: Adding fusiondspeq DSP Signal Path Element
Sep 17 20:27:29 raspberrypi volumio[31769]: info: FusionDsp - ---- installed callbackRead
Sep 17 20:27:29 raspberrypi volumio[31769]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:29 raspberrypi volumio[31769]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 17 20:27:29 raspberrypi volumio[31769]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 17 20:27:29 raspberrypi volumio[31769]: at onErrorNT (internal/child_process.js:465:16)
Sep 17 20:27:29 raspberrypi volumio[31769]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 17 20:27:29 raspberrypi volumio[31769]: at runNextTicks (internal/process/task_queues.js:62:3)
Sep 17 20:27:29 raspberrypi volumio[31769]: at listOnTimeout (internal/timers.js:523:9)
Sep 17 20:27:29 raspberrypi volumio[31769]: at processTimers (internal/timers.js:497:7) {
Sep 17 20:27:29 raspberrypi volumio[31769]: errno: -2,
Sep 17 20:27:29 raspberrypi volumio[31769]: code: 'ENOENT',
Sep 17 20:27:29 raspberrypi volumio[31769]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:29 raspberrypi volumio[31769]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:29 raspberrypi volumio[31769]: spawnargs: [
Sep 17 20:27:29 raspberrypi volumio[31769]: '-p',
Sep 17 20:27:29 raspberrypi volumio[31769]: 9876,
Sep 17 20:27:29 raspberrypi volumio[31769]: '-o',
Sep 17 20:27:29 raspberrypi volumio[31769]: '/tmp/camilladsp.log',
Sep 17 20:27:29 raspberrypi volumio[31769]: '-l',
Sep 17 20:27:29 raspberrypi volumio[31769]: 'warn',
Sep 17 20:27:29 raspberrypi volumio[31769]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 17 20:27:29 raspberrypi volumio[31769]: ]
Sep 17 20:27:29 raspberrypi volumio[31769]: }
Sep 17 20:27:29 raspberrypi volumio[31769]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:30 raspberrypi sudo[31995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 20:26
Sep 17 20:27:30 raspberrypi sudo[31995]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:30 raspberrypi sudo[31995]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:30 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:30] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 17 20:27:30 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:30] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 17 20:27:30 raspberrypi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:30 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:30 raspberrypi sudo[31981]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:30 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 40.
Sep 17 20:27:30 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:30 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:30 raspberrypi systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 17 20:27:30 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:30 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:31 raspberrypi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 17 20:27:31 raspberrypi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11.
Sep 17 20:27:31 raspberrypi systemd[1]: Stopped Volumio Backend Module.
Sep 17 20:27:31 raspberrypi systemd[1]: Started Volumio Backend Module.
Sep 17 20:27:31 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:31 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:32 raspberrypi volumio[32001]: Traceback (most recent call last):
Sep 17 20:27:32 raspberrypi volumio[32001]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:32 raspberrypi volumio[32001]: from camilladsp import CamillaConnection
Sep 17 20:27:32 raspberrypi volumio[32001]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:32 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:32 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:33 raspberrypi volumio[32008]: info: -------------------------------------------
Sep 17 20:27:33 raspberrypi volumio[32008]: info: ----- Volumio3 ----
Sep 17 20:27:33 raspberrypi volumio[32008]: info: -------------------------------------------
Sep 17 20:27:33 raspberrypi volumio[32008]: info: ----- System startup ----
Sep 17 20:27:33 raspberrypi volumio[32008]: info: -------------------------------------------
Sep 17 20:27:33 raspberrypi volumio[32008]: info: MYVOLUMIO Environment detected
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Plugin folders cleanup
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning into folder /volumio/app/plugins/
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category audio_interface
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category miscellanea
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category music_service
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category plugins.json
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category system_controller
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category user_interface
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning into folder /data/plugins/
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category audio_interface
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Scanning category music_service
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Plugin folders cleanup completed
Sep 17 20:27:33 raspberrypi volumio[32008]: info: -------------------------------------------
Sep 17 20:27:33 raspberrypi volumio[32008]: info: ----- Core plugins startup ----
Sep 17 20:27:33 raspberrypi volumio[32008]: info: -------------------------------------------
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Loading plugins from folder /volumio/app/plugins/
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Adding plugin upnp to MyMusic Plugins
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Loading plugins from folder /data/plugins/
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Loading plugin "system"...
Sep 17 20:27:33 raspberrypi volumio[32008]: info: Loading plugin "appearance"...
Sep 17 20:27:34 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:34 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 41.
Sep 17 20:27:34 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:34 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "network"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Refreshing Cached IP Addresses
Sep 17 20:27:35 raspberrypi sudo[32089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 20:27:35 raspberrypi sudo[32089]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:35 raspberrypi sudo[32089]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:35 raspberrypi sudo[32091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 20:27:35 raspberrypi sudo[32091]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:35 raspberrypi sudo[32091]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "services"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "alsa_controller"...
Sep 17 20:27:35 raspberrypi sudo[32102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 17 20:27:35 raspberrypi sudo[32102]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:35 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "wizard"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "networkfs"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Starting Udev Watcher for removable devices
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Ignoring mount for partition: boot
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Ignoring mount for partition: volumio
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Ignoring mount for partition: volumio_data
Sep 17 20:27:35 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "volumio_command_line_client"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "upnp"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: [1758133655372] Starting Upmpd Daemon
Sep 17 20:27:35 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "my_music"...
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "mpd"...
Sep 17 20:27:35 raspberrypi volumio[32087]: Traceback (most recent call last):
Sep 17 20:27:35 raspberrypi volumio[32087]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:35 raspberrypi volumio[32087]: from camilladsp import CamillaConnection
Sep 17 20:27:35 raspberrypi volumio[32087]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:35 raspberrypi volumio[32008]: info: Loading plugin "upnp_browser"...
Sep 17 20:27:35 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:35 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:35 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:35] [connect] Successful connection
Sep 17 20:27:36 raspberrypi sudo[32102]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "alarm-clock"...
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "airplay_emulation"...
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Starting Shairport Sync
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "last_100"...
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "webradio"...
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "i2s_dacs"...
Sep 17 20:27:36 raspberrypi volumio[32008]: info: I2S DAC not set, start Auto-detection
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "volumiodiscovery"...
Sep 17 20:27:36 raspberrypi volumio[32008]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:36 raspberrypi volumio[32008]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:36 raspberrypi volumio[32008]: *** WARNING *** For more information see
Sep 17 20:27:36 raspberrypi volumio[32008]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:36 raspberrypi node[32008]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:36 raspberrypi volumio[32008]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:36 raspberrypi volumio[32008]: *** WARNING *** For more information see
Sep 17 20:27:36 raspberrypi node[32008]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:36 raspberrypi node[32008]: *** WARNING *** For more information see
Sep 17 20:27:36 raspberrypi node[32008]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:36 raspberrypi node[32008]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:36 raspberrypi node[32008]: *** WARNING *** For more information see
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Discovery: Started advertising with name: raspberrypi
Sep 17 20:27:36 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:36 raspberrypi volumio[32008]: info: Loading plugin "spop"...
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "outputs"...
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "albumart"...
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Plugin example_plugin is not enabled
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "inputs"...
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "updater_comm"...
Sep 17 20:27:37 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:37 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 42.
Sep 17 20:27:37 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Plugin mpdemulation is not enabled
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "rest_api"...
Sep 17 20:27:37 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "websocket"...
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Starting Socket.io Server version 2.3.0
Sep 17 20:27:37 raspberrypi volumio[32008]: info: Loading plugin "fusiondsp"...
Sep 17 20:27:38 raspberrypi volumio[32008]: Forking 3 albumart workers
Sep 17 20:27:38 raspberrypi volumio[32008]: info: Applying required configuration parameters for plugin fusiondsp
Sep 17 20:27:38 raspberrypi volumio[32008]: info: Loading i18n strings for locale pl
Sep 17 20:27:38 raspberrypi volumio[32008]: Updating browse sources language
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::initPlayerControls
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:38 raspberrypi volumio[32008]: Express server listening on port 3000
Sep 17 20:27:38 raspberrypi volumio[32008]: [Metrics] WebUI: 6s 346.19ms
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreStateMachine::resetVolumioState
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreStateMachine::getcurrentVolume
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:38 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Volumio Network Manager: Network status updated: 3
Sep 17 20:27:39 raspberrypi volumio[32008]: Starting albumart workers
Sep 17 20:27:39 raspberrypi volumio[32125]: Traceback (most recent call last):
Sep 17 20:27:39 raspberrypi volumio[32125]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:39 raspberrypi volumio[32125]: from camilladsp import CamillaConnection
Sep 17 20:27:39 raspberrypi volumio[32125]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:39 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1758133655 101
Sep 17 20:27:39 raspberrypi volumio[32008]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
Sep 17 20:27:39 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:39 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Reloading queue from file
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::setRepeat false single undefined
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::pushState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::setRandom null
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::pushState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:39 raspberrypi volumio[32008]: Starting albumart workers
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Setting Device type: Raspberry PI
Sep 17 20:27:39 raspberrypi volumio[32008]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::pushState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::updateTrackBlock
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrackBlock
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Completed loading Core Plugins
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:39 raspberrypi volumio[32008]: Starting albumart workers
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Discovery: adding 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Discovery: Found device raspberrypi
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Discovery: this is already registered, 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Discovery: Found device raspberrypi
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:39 raspberrypi volumio[32008]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:39 raspberrypi volumio[32008]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:39 raspberrypi volumio[32008]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreStateMachine::pushState
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:39 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Output device has changed, restarting MPD
Sep 17 20:27:40 raspberrypi sudo[32161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 20:27:40 raspberrypi sudo[32161]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 20:27:40 raspberrypi sudo[32163]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32161]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:40 raspberrypi sudo[32163]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:40 raspberrypi sudo[32176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:40 raspberrypi sudo[32176]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:40 raspberrypi sudo[32177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32176]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:40 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:27:40 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:40 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:40 raspberrypi volumio[32008]: info: ___________ START PLUGINS ___________
Sep 17 20:27:40 raspberrypi volumio[32008]: info: ControllerMpd::onStart: Initializing MPD
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Creating MPD Configuration file
Sep 17 20:27:40 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:40 raspberrypi sudo[32185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:40 raspberrypi sudo[32185]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32185]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:40 raspberrypi volumio[32008]: info: [1758133660399] CoreMusicLibrary::Adding element Serwery Mediów
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:40 raspberrypi sudo[32188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:40 raspberrypi sudo[32188]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:40 raspberrypi sudo[32183]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:40 raspberrypi sudo[32183]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32183]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:40 raspberrypi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 17 20:27:40 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:40 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:40 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:40 raspberrypi volumio[32008]: info: [1758133660639] CoreMusicLibrary::Adding element Last_100
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:40 raspberrypi volumio[32008]: info: [1758133660644] CoreMusicLibrary::Adding element Webradio
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Initializing BBC Radios
Sep 17 20:27:40 raspberrypi sudo[32199]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:40 raspberrypi sudo[32199]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:40 raspberrypi sudo[32199]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Creating Spotify config file
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Loading i18n strings for locale pl
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 17 20:27:40 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:40 raspberrypi volumio[32008]: info: FusionDsp - mixtype--------------------- Hardware
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Volumio Calling Home
Sep 17 20:27:40 raspberrypi volumio[32008]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 20:27:41 raspberrypi volumio[32008]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:41 raspberrypi volumio[32008]: info: MPD Permissions set
Sep 17 20:27:41 raspberrypi volumio[32008]: info: MPD Permissions set
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Volumio called home
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Spotify config file written
Sep 17 20:27:41 raspberrypi volumio[32008]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 17 20:27:41 raspberrypi sudo[32229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 17 20:27:41 raspberrypi sudo[32229]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:41 raspberrypi volumio[32008]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi systemd[1]: Stopping go-librespot Daemon...
Sep 17 20:27:41 raspberrypi systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:41 raspberrypi systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 17 20:27:41 raspberrypi systemd[1]: Stopped go-librespot Daemon.
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:41 raspberrypi volumio[32008]: info: No need to fix Spotify hosts
Sep 17 20:27:41 raspberrypi systemd[1]: Started go-librespot Daemon.
Sep 17 20:27:41 raspberrypi sudo[32229]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:41 raspberrypi go-librespot[32235]: go-librespot daemon starting...
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=info msg="running go-librespot 0.3.2"
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=debug msg="app state loaded"
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=debug msg="stored credentials not found"
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Sep 17 20:27:41 raspberrypi go-librespot[32235]: time="2025-09-17T20:27:41+02:00" level=info msg="zeroconf server listening on port 40243"
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetQueue
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreStateMachine::getQueue
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CorePlayQueue::getQueue
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Listing playlists
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Received Get System Info
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Discovery: Getting this device information
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 17 20:27:41 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Starting Shairport Sync
Sep 17 20:27:41 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 43.
Sep 17 20:27:41 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Starting Shairport Sync
Sep 17 20:27:41 raspberrypi sudo[32249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:41 raspberrypi sudo[32249]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Starting Shairport Sync
Sep 17 20:27:41 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:41 raspberrypi sudo[32251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:41 raspberrypi sudo[32251]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:41 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:41 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:41 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:41 raspberrypi sudo[32254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:41 raspberrypi sudo[32254]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:41 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:41 raspberrypi sudo[32249]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:41 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:41 raspberrypi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:41 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:41 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:41 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:41 raspberrypi sudo[32254]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:41 raspberrypi sudo[32251]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:41 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Shairport-Sync Started
Sep 17 20:27:41 raspberrypi volumio[32008]: Error adding Membership: Error: addMembership EINVAL
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Shairport-Sync Started
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:41 raspberrypi volumio[32008]: info: Output device has changed, restarting MPD
Sep 17 20:27:42 raspberrypi sudo[32263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:42 raspberrypi sudo[32263]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:42 raspberrypi sudo[32263]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:42 raspberrypi sudo[32265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:42 raspberrypi sudo[32265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:42 raspberrypi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:42 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:42 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Received Get System Info
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Discovery: Getting this device information
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:42 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:42 raspberrypi volumio[32008]: info: MPD Permissions set
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Listing playlists
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Listing playlists
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: info: FusionDsp -
Sep 17 20:27:42 raspberrypi sudo[32271]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:42 raspberrypi sudo[32271]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:42 raspberrypi sudo[32271]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:42 raspberrypi volumio[32008]: info: FusionDsp - undefined
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Starting Shairport Sync
Sep 17 20:27:42 raspberrypi sudo[32279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:42 raspberrypi sudo[32279]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:42 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:42 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:42 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:42 raspberrypi volumio[32008]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:42 raspberrypi volumio[32008]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 17 20:27:42 raspberrypi volumio[32008]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:27:42 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:42 raspberrypi sudo[32279]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:42 raspberrypi volumio[32008]: info: camilladsp service started and running in background, instance 1
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:42 raspberrypi volumio[32008]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:42 raspberrypi volumio[32008]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Sep 17 20:27:42 raspberrypi volumio[32008]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:27:42 raspberrypi volumio[32008]: info: FusionDsp loaded
Sep 17 20:27:42 raspberrypi volumio[32008]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:42 raspberrypi sudo[32294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 17 20:27:42 raspberrypi sudo[32294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:42 raspberrypi volumio[32008]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Adding Signal Path Element [object Object]
Sep 17 20:27:42 raspberrypi volumio[32008]: info: Adding fusiondspeq DSP Signal Path Element
Sep 17 20:27:42 raspberrypi volumio[32008]: info: FusionDsp - ---- installed callbackRead
Sep 17 20:27:43 raspberrypi volumio[32008]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:43 raspberrypi sudo[32294]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:43 raspberrypi volumio[32008]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 17 20:27:43 raspberrypi volumio[32008]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 17 20:27:43 raspberrypi volumio[32008]: at onErrorNT (internal/child_process.js:465:16)
Sep 17 20:27:43 raspberrypi volumio[32008]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Sep 17 20:27:43 raspberrypi volumio[32008]: errno: -2,
Sep 17 20:27:43 raspberrypi volumio[32008]: code: 'ENOENT',
Sep 17 20:27:43 raspberrypi volumio[32008]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:43 raspberrypi volumio[32008]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:27:43 raspberrypi volumio[32008]: spawnargs: [
Sep 17 20:27:43 raspberrypi volumio[32008]: '-p',
Sep 17 20:27:43 raspberrypi volumio[32008]: 9876,
Sep 17 20:27:43 raspberrypi volumio[32008]: '-o',
Sep 17 20:27:43 raspberrypi volumio[32008]: '/tmp/camilladsp.log',
Sep 17 20:27:43 raspberrypi volumio[32008]: '-l',
Sep 17 20:27:43 raspberrypi volumio[32008]: 'warn',
Sep 17 20:27:43 raspberrypi volumio[32008]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 17 20:27:43 raspberrypi volumio[32008]: ]
Sep 17 20:27:43 raspberrypi volumio[32008]: }
Sep 17 20:27:43 raspberrypi volumio[32008]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:43 raspberrypi volumio[32247]: Traceback (most recent call last):
Sep 17 20:27:43 raspberrypi volumio[32247]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:43 raspberrypi volumio[32247]: from camilladsp import CamillaConnection
Sep 17 20:27:43 raspberrypi volumio[32247]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:43 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:43 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:43 raspberrypi sudo[32305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 20:26
Sep 17 20:27:43 raspberrypi sudo[32305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:43 raspberrypi sudo[32305]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:44 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:44] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 17 20:27:44 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:44] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 17 20:27:44 raspberrypi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:44 raspberrypi mpd[32277]: Sep 17 20:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 20:27:44 raspberrypi sudo[32188]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:44 raspberrypi sudo[32265]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:44 raspberrypi sudo[32177]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:44 raspberrypi systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 17 20:27:44 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:44 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:44 raspberrypi systemd[1]: Started Music Player Daemon.
Sep 17 20:27:44 raspberrypi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 17 20:27:44 raspberrypi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12.
Sep 17 20:27:44 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:44 raspberrypi systemd[1]: Stopped Volumio Backend Module.
Sep 17 20:27:44 raspberrypi systemd[1]: Started Volumio Backend Module.
Sep 17 20:27:44 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:45 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:45 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 44.
Sep 17 20:27:45 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:45 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:46 raspberrypi volumio[32318]: info: -------------------------------------------
Sep 17 20:27:46 raspberrypi volumio[32318]: info: ----- Volumio3 ----
Sep 17 20:27:46 raspberrypi volumio[32318]: info: -------------------------------------------
Sep 17 20:27:46 raspberrypi volumio[32318]: info: ----- System startup ----
Sep 17 20:27:46 raspberrypi volumio[32318]: info: -------------------------------------------
Sep 17 20:27:46 raspberrypi volumio[32330]: Traceback (most recent call last):
Sep 17 20:27:46 raspberrypi volumio[32330]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:46 raspberrypi volumio[32330]: from camilladsp import CamillaConnection
Sep 17 20:27:46 raspberrypi volumio[32330]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:46 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:46 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:47 raspberrypi volumio[32318]: info: MYVOLUMIO Environment detected
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Plugin folders cleanup
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning into folder /volumio/app/plugins/
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category audio_interface
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category miscellanea
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category music_service
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category plugins.json
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category system_controller
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category user_interface
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning into folder /data/plugins/
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category audio_interface
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Scanning category music_service
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Plugin folders cleanup completed
Sep 17 20:27:47 raspberrypi volumio[32318]: info: -------------------------------------------
Sep 17 20:27:47 raspberrypi volumio[32318]: info: ----- Core plugins startup ----
Sep 17 20:27:47 raspberrypi volumio[32318]: info: -------------------------------------------
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Loading plugins from folder /volumio/app/plugins/
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Adding plugin upnp to MyMusic Plugins
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Loading plugins from folder /data/plugins/
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Loading plugin "system"...
Sep 17 20:27:47 raspberrypi volumio[32318]: info: Loading plugin "appearance"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "network"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Refreshing Cached IP Addresses
Sep 17 20:27:48 raspberrypi sudo[32345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 20:27:48 raspberrypi sudo[32345]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:48 raspberrypi sudo[32345]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:48 raspberrypi sudo[32347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 20:27:48 raspberrypi sudo[32347]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:48 raspberrypi sudo[32347]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "services"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "alsa_controller"...
Sep 17 20:27:48 raspberrypi sudo[32360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 17 20:27:48 raspberrypi sudo[32360]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:48 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "wizard"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "networkfs"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Starting Udev Watcher for removable devices
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Ignoring mount for partition: boot
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Ignoring mount for partition: volumio
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Ignoring mount for partition: volumio_data
Sep 17 20:27:48 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "volumio_command_line_client"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "upnp"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: [1758133668476] Starting Upmpd Daemon
Sep 17 20:27:48 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "my_music"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "mpd"...
Sep 17 20:27:48 raspberrypi volumio[32318]: info: Loading plugin "upnp_browser"...
Sep 17 20:27:48 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:48 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 45.
Sep 17 20:27:48 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:48 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:49 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:49] [connect] Successful connection
Sep 17 20:27:49 raspberrypi sudo[32360]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "alarm-clock"...
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "airplay_emulation"...
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Starting Shairport Sync
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "last_100"...
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "webradio"...
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "i2s_dacs"...
Sep 17 20:27:49 raspberrypi volumio[32318]: info: I2S DAC not set, start Auto-detection
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "volumiodiscovery"...
Sep 17 20:27:49 raspberrypi volumio[32318]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:49 raspberrypi volumio[32318]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:49 raspberrypi volumio[32318]: *** WARNING *** For more information see
Sep 17 20:27:49 raspberrypi node[32318]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:49 raspberrypi volumio[32318]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:49 raspberrypi volumio[32318]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:49 raspberrypi volumio[32318]: *** WARNING *** For more information see
Sep 17 20:27:49 raspberrypi node[32318]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:49 raspberrypi node[32318]: *** WARNING *** For more information see
Sep 17 20:27:49 raspberrypi node[32318]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:27:49 raspberrypi node[32318]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:27:49 raspberrypi node[32318]: *** WARNING *** For more information see
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Discovery: Started advertising with name: raspberrypi
Sep 17 20:27:49 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:27:49 raspberrypi volumio[32318]: info: Loading plugin "spop"...
Sep 17 20:27:50 raspberrypi volumio[32372]: Traceback (most recent call last):
Sep 17 20:27:50 raspberrypi volumio[32372]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:50 raspberrypi volumio[32372]: from camilladsp import CamillaConnection
Sep 17 20:27:50 raspberrypi volumio[32372]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:50 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:50 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:50 raspberrypi volumio[32318]: info: Loading plugin "outputs"...
Sep 17 20:27:50 raspberrypi volumio[32318]: info: Loading plugin "albumart"...
Sep 17 20:27:50 raspberrypi volumio[32318]: info: Plugin example_plugin is not enabled
Sep 17 20:27:50 raspberrypi volumio[32318]: info: Loading plugin "inputs"...
Sep 17 20:27:50 raspberrypi volumio[32318]: info: Loading plugin "updater_comm"...
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Plugin mpdemulation is not enabled
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Loading plugin "rest_api"...
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Loading plugin "websocket"...
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Starting Socket.io Server version 2.3.0
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Loading plugin "fusiondsp"...
Sep 17 20:27:51 raspberrypi volumio[32318]: Forking 3 albumart workers
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Applying required configuration parameters for plugin fusiondsp
Sep 17 20:27:51 raspberrypi volumio[32318]: info: Loading i18n strings for locale pl
Sep 17 20:27:51 raspberrypi volumio[32318]: Updating browse sources language
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::initPlayerControls
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:51 raspberrypi volumio[32318]: Express server listening on port 3000
Sep 17 20:27:51 raspberrypi volumio[32318]: [Metrics] WebUI: 6s 213.66ms
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreStateMachine::resetVolumioState
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreStateMachine::getcurrentVolume
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:51 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Volumio Network Manager: Network status updated: 3
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 3
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 4
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 6
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 7
Sep 17 20:27:52 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1758133669 101
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 9
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 10
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 11
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 12
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 13
Sep 17 20:27:52 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:52 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 46.
Sep 17 20:27:52 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:52 raspberrypi volumio[32318]: Starting albumart workers
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 14
Sep 17 20:27:52 raspberrypi volumio[32318]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 15
Sep 17 20:27:52 raspberrypi volumio[32318]: Starting albumart workers
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Reloading queue from file
Sep 17 20:27:52 raspberrypi volumio[32318]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::pushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::updateTrackBlock
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrackBlock
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:27:52 raspberrypi volumio[32318]: Starting albumart workers
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::setRepeat false single undefined
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::pushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::setRandom null
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::pushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Setting Device type: Raspberry PI
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Received Get System Info
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Discovery: Getting this device information
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetQueue
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::getQueue
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getQueue
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Listing playlists
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Received Get System Info
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Discovery: Getting this device information
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreStateMachine::pushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioPushState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Discovery: adding 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:52 raspberrypi volumio[32318]: info: Discovery: Found device raspberrypi
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:52 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:53 raspberrypi volumio[32318]: info: Discovery: this is already registered, 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:27:53 raspberrypi volumio[32318]: info: Discovery: Found device raspberrypi
Sep 17 20:27:53 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:53 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:53 raspberrypi volumio[32318]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:53 raspberrypi volumio[32318]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:53 raspberrypi volumio[32318]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:53 raspberrypi volumio[32318]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:27:53 raspberrypi volumio[32318]: info: Completed loading Core Plugins
Sep 17 20:27:53 raspberrypi volumio[32318]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:53 raspberrypi volumio[32318]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:53 raspberrypi volumio[32318]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:53 raspberrypi volumio[32318]: info: FusionDsp -
Sep 17 20:27:53 raspberrypi volumio[32318]: info: FusionDsp -
Sep 17 20:27:53 raspberrypi volumio[32410]: Traceback (most recent call last):
Sep 17 20:27:53 raspberrypi volumio[32410]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:53 raspberrypi volumio[32410]: from camilladsp import CamillaConnection
Sep 17 20:27:53 raspberrypi volumio[32410]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:53 raspberrypi volumio[32318]: info: FusionDsp -
Sep 17 20:27:53 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:53 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:54 raspberrypi volumio[32318]: info: FusionDsp -
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 20:27:54 raspberrypi volumio[32318]: info: FusionDsp - undefined
Sep 17 20:27:54 raspberrypi volumio[32318]: info: FusionDsp - undefined
Sep 17 20:27:54 raspberrypi volumio[32318]: info: FusionDsp - undefined
Sep 17 20:27:54 raspberrypi volumio[32318]: info: FusionDsp - undefined
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Output device has changed, restarting MPD
Sep 17 20:27:54 raspberrypi sudo[32445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:54 raspberrypi sudo[32445]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:54 raspberrypi sudo[32445]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:54 raspberrypi sudo[32447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:54 raspberrypi sudo[32447]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:54 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:54 raspberrypi volumio[32318]: info: ___________ START PLUGINS ___________
Sep 17 20:27:54 raspberrypi volumio[32318]: info: ControllerMpd::onStart: Initializing MPD
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Creating MPD Configuration file
Sep 17 20:27:54 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:54 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:54 raspberrypi sudo[32455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:54 raspberrypi volumio[32318]: info: [1758133674689] CoreMusicLibrary::Adding element Serwery Mediów
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:54 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:54 raspberrypi sudo[32455]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:54 raspberrypi sudo[32455]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:54 raspberrypi sudo[32458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:54 raspberrypi sudo[32458]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:54 raspberrypi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 17 20:27:54 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:54 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:54 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:54 raspberrypi volumio[32318]: info: [1758133674843] CoreMusicLibrary::Adding element Last_100
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:27:54 raspberrypi volumio[32318]: info: [1758133674847] CoreMusicLibrary::Adding element Webradio
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Initializing BBC Radios
Sep 17 20:27:54 raspberrypi sudo[32464]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:54 raspberrypi sudo[32464]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:54 raspberrypi sudo[32464]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Creating Spotify config file
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Loading i18n strings for locale pl
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 17 20:27:54 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:54 raspberrypi volumio[32318]: info: FusionDsp - mixtype--------------------- Hardware
Sep 17 20:27:54 raspberrypi volumio[32318]: info: Volumio Calling Home
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Preparing to generate the ALSA configuration file
Sep 17 20:27:55 raspberrypi volumio[32318]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Reading ALSA contributions from plugins.
Sep 17 20:27:55 raspberrypi volumio[32318]: info: MPD Permissions set
Sep 17 20:27:55 raspberrypi volumio[32318]: info: MPD Permissions set
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Spotify config file written
Sep 17 20:27:55 raspberrypi sudo[32483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 17 20:27:55 raspberrypi sudo[32483]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:55 raspberrypi volumio[32318]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Volumio called home
Sep 17 20:27:55 raspberrypi systemd[1]: Stopping go-librespot Daemon...
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:55 raspberrypi systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:55 raspberrypi systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 17 20:27:55 raspberrypi systemd[1]: Stopped go-librespot Daemon.
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:55 raspberrypi systemd[1]: Started go-librespot Daemon.
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:55 raspberrypi go-librespot[32485]: go-librespot daemon starting...
Sep 17 20:27:55 raspberrypi sudo[32483]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=info msg="running go-librespot 0.3.2"
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=debug msg="app state loaded"
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=debug msg="stored credentials not found"
Sep 17 20:27:55 raspberrypi volumio[32318]: info: No need to fix Spotify hosts
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Starting Shairport Sync
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Starting Shairport Sync
Sep 17 20:27:55 raspberrypi sudo[32503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Starting Shairport Sync
Sep 17 20:27:55 raspberrypi sudo[32503]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]"
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Sep 17 20:27:55 raspberrypi sudo[32506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:55 raspberrypi go-librespot[32485]: time="2025-09-17T20:27:55+02:00" level=info msg="zeroconf server listening on port 42531"
Sep 17 20:27:55 raspberrypi sudo[32508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:55 raspberrypi sudo[32508]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:55 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:55 raspberrypi sudo[32506]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:55 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioGetState
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CorePlayQueue::getTrack 0
Sep 17 20:27:55 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Output device has changed, restarting MPD
Sep 17 20:27:55 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:55 raspberrypi volumio[32318]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:55 raspberrypi sudo[32503]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:55 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:55 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:55 raspberrypi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:55 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:55 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:55 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:55 raspberrypi sudo[32515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:27:55 raspberrypi sudo[32515]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:55 raspberrypi sudo[32514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:27:55 raspberrypi sudo[32514]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:55 raspberrypi sudo[32508]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:55 raspberrypi sudo[32506]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:55 raspberrypi sudo[32515]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:55 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:55 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 47.
Sep 17 20:27:56 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:27:56 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:27:56 raspberrypi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:27:56 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:27:56 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:27:56 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:27:56 raspberrypi volumio[32318]: info: MPD Permissions set
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Shairport-Sync Started
Sep 17 20:27:56 raspberrypi volumio[32318]: Error adding Membership: Error: addMembership EINVAL
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Shairport-Sync Started
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Shairport-Sync Started
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Starting Shairport Sync
Sep 17 20:27:56 raspberrypi sudo[32525]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:27:56 raspberrypi sudo[32525]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:56 raspberrypi sudo[32532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:27:56 raspberrypi sudo[32532]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:56 raspberrypi sudo[32525]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:56 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:27:56 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:27:56 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:56 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:27:56 raspberrypi sudo[32532]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Shairport-Sync Started
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Preload queue cleared
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreStateMachine::ClearQueue
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreStateMachine::stop
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CorePlayQueue::clearPlayQueue
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CorePlayQueue::saveQueue
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreCommandRouter::volumioPushQueue
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CoreStateMachine::addQueueItems
Sep 17 20:27:56 raspberrypi volumio[32318]: info: CorePlayQueue::addQueueItems
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Preload queue cleared
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Adding Item to queue: music-library/NAS/Music/The Doors/The Doors - Discography [FLAC] [PMEDIA]/(1968) - The Doors - Waiting For The Sun [24Bit-96kHz]/01. Hello, I Love You.flac
Sep 17 20:27:56 raspberrypi volumio[32318]: info: Exploding uri music-library/NAS/Music/The Doors/The Doors - Discography [FLAC] [PMEDIA]/(1968) - The Doors - Waiting For The Sun [24Bit-96kHz]/01. Hello, I Love You.flac in service mpd
Sep 17 20:27:56 raspberrypi volumio[32318]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:56 raspberrypi volumio[32318]: TypeError: Cannot read property 'then' of undefined
Sep 17 20:27:56 raspberrypi volumio[32318]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19)
Sep 17 20:27:56 raspberrypi volumio[32318]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:249:25)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:511:25)
Sep 17 20:27:56 raspberrypi volumio[32318]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17)
Sep 17 20:27:56 raspberrypi volumio[32318]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33)
Sep 17 20:27:56 raspberrypi volumio[32318]: at Socket.emit (events.js:315:20)
Sep 17 20:27:56 raspberrypi volumio[32318]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Sep 17 20:27:56 raspberrypi volumio[32318]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Sep 17 20:27:56 raspberrypi volumio[32318]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:27:57 raspberrypi volumio[32522]: Traceback (most recent call last):
Sep 17 20:27:57 raspberrypi volumio[32522]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:27:57 raspberrypi volumio[32522]: from camilladsp import CamillaConnection
Sep 17 20:27:57 raspberrypi volumio[32522]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:27:57 raspberrypi sudo[32548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 20:26
Sep 17 20:27:57 raspberrypi sudo[32548]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:27:57 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:57 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:27:57 raspberrypi sudo[32548]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:57 raspberrypi mpd[32535]: Sep 17 20:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 20:27:58 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:58] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 17 20:27:58 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:27:58] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 17 20:27:58 raspberrypi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:27:58 raspberrypi systemd[1]: Started Music Player Daemon.
Sep 17 20:27:58 raspberrypi sudo[32447]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:58 raspberrypi sudo[32458]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:58 raspberrypi sudo[32514]: pam_unix(sudo:session): session closed for user root
Sep 17 20:27:58 raspberrypi systemd[1]: volumio.service: Failed with result 'exit-code'.
Sep 17 20:27:58 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:58 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:58 raspberrypi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 17 20:27:58 raspberrypi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13.
Sep 17 20:27:58 raspberrypi systemd[1]: Stopped Volumio Backend Module.
Sep 17 20:27:58 raspberrypi systemd[1]: Started Volumio Backend Module.
Sep 17 20:27:58 raspberrypi systemd[1]: Started dynamicswap service.
Sep 17 20:27:58 raspberrypi systemd[1]: dynamicswap.service: Succeeded.
Sep 17 20:27:59 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:27:59 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 48.
Sep 17 20:27:59 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:27:59 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:28:00 raspberrypi volumio[32564]: info: -------------------------------------------
Sep 17 20:28:00 raspberrypi volumio[32564]: info: ----- Volumio3 ----
Sep 17 20:28:00 raspberrypi volumio[32564]: info: -------------------------------------------
Sep 17 20:28:00 raspberrypi volumio[32564]: info: ----- System startup ----
Sep 17 20:28:00 raspberrypi volumio[32564]: info: -------------------------------------------
Sep 17 20:28:00 raspberrypi volumio[32564]: info: MYVOLUMIO Environment detected
Sep 17 20:28:00 raspberrypi volumio[32577]: Traceback (most recent call last):
Sep 17 20:28:00 raspberrypi volumio[32577]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:28:00 raspberrypi volumio[32577]: from camilladsp import CamillaConnection
Sep 17 20:28:00 raspberrypi volumio[32577]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Plugin folders cleanup
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning into folder /volumio/app/plugins/
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category audio_interface
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category miscellanea
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category music_service
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category plugins.json
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category system_controller
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category user_interface
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning into folder /data/plugins/
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category audio_interface
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Scanning category music_service
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Plugin folders cleanup completed
Sep 17 20:28:00 raspberrypi volumio[32564]: info: -------------------------------------------
Sep 17 20:28:00 raspberrypi volumio[32564]: info: ----- Core plugins startup ----
Sep 17 20:28:00 raspberrypi volumio[32564]: info: -------------------------------------------
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Loading plugins from folder /volumio/app/plugins/
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Adding plugin upnp to MyMusic Plugins
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Loading plugins from folder /data/plugins/
Sep 17 20:28:00 raspberrypi volumio[32564]: info: Loading plugin "system"...
Sep 17 20:28:01 raspberrypi volumio[32564]: info: Loading plugin "appearance"...
Sep 17 20:28:01 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:28:01 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "network"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Refreshing Cached IP Addresses
Sep 17 20:28:02 raspberrypi sudo[32593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 20:28:02 raspberrypi sudo[32593]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:02 raspberrypi sudo[32593]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:02 raspberrypi sudo[32595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 20:28:02 raspberrypi sudo[32595]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:02 raspberrypi sudo[32595]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "services"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "alsa_controller"...
Sep 17 20:28:02 raspberrypi sudo[32607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 17 20:28:02 raspberrypi sudo[32607]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:02 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "wizard"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "networkfs"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Starting Udev Watcher for removable devices
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Ignoring mount for partition: boot
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Ignoring mount for partition: volumio
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Ignoring mount for partition: volumio_data
Sep 17 20:28:02 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "volumio_command_line_client"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "upnp"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: [1758133682322] Starting Upmpd Daemon
Sep 17 20:28:02 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "my_music"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "mpd"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "upnp_browser"...
Sep 17 20:28:02 raspberrypi volumio[32564]: info: Loading plugin "alarm-clock"...
Sep 17 20:28:03 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:28:03] [connect] Successful connection
Sep 17 20:28:03 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:28:03 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 49.
Sep 17 20:28:03 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:28:03 raspberrypi sudo[32607]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:03 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Loading plugin "airplay_emulation"...
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Starting Shairport Sync
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Loading plugin "last_100"...
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Loading plugin "webradio"...
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Loading plugin "i2s_dacs"...
Sep 17 20:28:03 raspberrypi volumio[32564]: info: I2S DAC not set, start Auto-detection
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Loading plugin "volumiodiscovery"...
Sep 17 20:28:03 raspberrypi volumio[32564]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:28:03 raspberrypi volumio[32564]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:28:03 raspberrypi volumio[32564]: *** WARNING *** For more information see
Sep 17 20:28:03 raspberrypi node[32564]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:28:03 raspberrypi volumio[32564]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:28:03 raspberrypi volumio[32564]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:28:03 raspberrypi volumio[32564]: *** WARNING *** For more information see
Sep 17 20:28:03 raspberrypi node[32564]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:28:03 raspberrypi node[32564]: *** WARNING *** For more information see
Sep 17 20:28:03 raspberrypi node[32564]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 20:28:03 raspberrypi node[32564]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 20:28:03 raspberrypi node[32564]: *** WARNING *** For more information see
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Discovery: Started advertising with name: raspberrypi
Sep 17 20:28:03 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 20:28:03 raspberrypi volumio[32564]: info: Loading plugin "spop"...
Sep 17 20:28:04 raspberrypi volumio[32620]: Traceback (most recent call last):
Sep 17 20:28:04 raspberrypi volumio[32620]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:28:04 raspberrypi volumio[32620]: from camilladsp import CamillaConnection
Sep 17 20:28:04 raspberrypi volumio[32620]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:28:04 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:28:04 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Loading plugin "outputs"...
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Loading plugin "albumart"...
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Plugin example_plugin is not enabled
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Loading plugin "inputs"...
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Loading plugin "updater_comm"...
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Plugin mpdemulation is not enabled
Sep 17 20:28:04 raspberrypi volumio[32564]: info: Loading plugin "rest_api"...
Sep 17 20:28:05 raspberrypi volumio[32564]: info: Loading plugin "websocket"...
Sep 17 20:28:05 raspberrypi volumio[32564]: info: Starting Socket.io Server version 2.3.0
Sep 17 20:28:05 raspberrypi volumio[32564]: info: Loading plugin "fusiondsp"...
Sep 17 20:28:05 raspberrypi volumio[32564]: Forking 3 albumart workers
Sep 17 20:28:05 raspberrypi volumio[32564]: info: Applying required configuration parameters for plugin fusiondsp
Sep 17 20:28:05 raspberrypi volumio[32564]: info: Loading i18n strings for locale pl
Sep 17 20:28:05 raspberrypi volumio[32564]: Updating browse sources language
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::initPlayerControls
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: Express server listening on port 3000
Sep 17 20:28:05 raspberrypi volumio[32564]: [Metrics] WebUI: 6s 293.74ms
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreStateMachine::resetVolumioState
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreStateMachine::getcurrentVolume
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:28:05 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:05 raspberrypi volumio[32564]: info: Volumio Network Manager: Network status updated: 3
Sep 17 20:28:05 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 1
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 2
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 3
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 4
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 5
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 6
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 7
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 8
Sep 17 20:28:06 raspberrypi volumio-remote-updater[591]: [2025-09-17 20:28:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1758133683 101
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 10
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 11
Sep 17 20:28:06 raspberrypi volumio[32564]: Starting albumart workers
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 12
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 13
Sep 17 20:28:06 raspberrypi volumio[32564]: Starting albumart workers
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.214 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 14
Sep 17 20:28:06 raspberrypi volumio[32564]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.152 UA: Mozilla/5.0 (X11; Linux x86_64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 15
Sep 17 20:28:06 raspberrypi volumio[32564]: Starting albumart workers
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Reloading queue from file
Sep 17 20:28:06 raspberrypi volumio[32564]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::pushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioPushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::updateTrackBlock
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrackBlock
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Setting Device type: Raspberry PI
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::setRepeat false single undefined
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::pushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioPushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::setRandom null
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::pushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioPushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Listing playlists
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Listing playlists
Sep 17 20:28:06 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:28:06 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 50.
Sep 17 20:28:06 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Received Get System Info
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Discovery: Getting this device information
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetQueue
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::getQueue
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getQueue
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Listing playlists
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Received Get System Info
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Discovery: Getting this device information
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: VolumeController:: Volume=0 Mute =false
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreStateMachine::pushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioPushState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Discovery: adding 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Discovery: Found device raspberrypi
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Completed loading Core Plugins
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Preparing to generate the ALSA configuration file
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Discovery: this is already registered, 1092a755-1821-4e66-be8c-eba752f9503e
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Discovery: Found device raspberrypi
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:06 raspberrypi volumio[32564]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:28:06 raspberrypi volumio[32564]: info: Reading ALSA contributions from plugins.
Sep 17 20:28:06 raspberrypi volumio[32564]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:28:07 raspberrypi volumio[32564]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:28:07 raspberrypi volumio[32564]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:28:07 raspberrypi volumio[32564]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 20:28:07 raspberrypi volumio[32564]: info: FusionDsp -
Sep 17 20:28:07 raspberrypi volumio[32564]: info: FusionDsp -
Sep 17 20:28:07 raspberrypi volumio[32564]: info: FusionDsp -
Sep 17 20:28:07 raspberrypi volumio[32564]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 20:28:07 raspberrypi volumio[32564]: info: FusionDsp -
Sep 17 20:28:08 raspberrypi volumio[32662]: Traceback (most recent call last):
Sep 17 20:28:08 raspberrypi volumio[32662]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:28:08 raspberrypi volumio[32662]: from camilladsp import CamillaConnection
Sep 17 20:28:08 raspberrypi volumio[32662]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:28:08 raspberrypi volumio[32564]: info: FusionDsp - undefined
Sep 17 20:28:08 raspberrypi volumio[32564]: info: FusionDsp - undefined
Sep 17 20:28:08 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:28:08 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:28:08 raspberrypi volumio[32564]: info: FusionDsp - undefined
Sep 17 20:28:08 raspberrypi volumio[32564]: info: FusionDsp - undefined
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Output device has changed, restarting MPD
Sep 17 20:28:08 raspberrypi sudo[32690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:28:08 raspberrypi sudo[32690]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:08 raspberrypi sudo[32690]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:08 raspberrypi sudo[32693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:28:08 raspberrypi sudo[32693]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:08 raspberrypi systemd[1]: Stopping Music Player Daemon...
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:28:08 raspberrypi volumio[32564]: info: ___________ START PLUGINS ___________
Sep 17 20:28:08 raspberrypi volumio[32564]: info: ControllerMpd::onStart: Initializing MPD
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Creating MPD Configuration file
Sep 17 20:28:08 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:28:08 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:28:08 raspberrypi sudo[32700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:28:08 raspberrypi sudo[32700]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:28:08 raspberrypi volumio[32564]: info: [1758133688472] CoreMusicLibrary::Adding element Serwery Mediów
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:28:08 raspberrypi sudo[32700]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:08 raspberrypi sudo[32702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:28:08 raspberrypi sudo[32702]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:08 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:08 raspberrypi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 17 20:28:08 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:28:08 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:28:08 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:28:08 raspberrypi volumio[32564]: info: [1758133688626] CoreMusicLibrary::Adding element Last_100
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 20:28:08 raspberrypi volumio[32564]: info: [1758133688631] CoreMusicLibrary::Adding element Webradio
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Initializing BBC Radios
Sep 17 20:28:08 raspberrypi sudo[32706]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:28:08 raspberrypi sudo[32706]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:08 raspberrypi sudo[32706]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Creating Spotify config file
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Loading i18n strings for locale pl
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 17 20:28:08 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:08 raspberrypi volumio[32564]: info: FusionDsp - mixtype--------------------- Hardware
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Volumio Calling Home
Sep 17 20:28:08 raspberrypi volumio[32564]: info: Preparing to generate the ALSA configuration file
Sep 17 20:28:09 raspberrypi volumio[32564]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Reading ALSA contributions from plugins.
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: MPD Permissions set
Sep 17 20:28:09 raspberrypi volumio[32564]: info: MPD Permissions set
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Volumio called home
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Spotify config file written
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi sudo[32728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Sep 17 20:28:09 raspberrypi sudo[32728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:09 raspberrypi systemd[1]: Stopping go-librespot Daemon...
Sep 17 20:28:09 raspberrypi systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:28:09 raspberrypi systemd[1]: go-librespot-daemon.service: Succeeded.
Sep 17 20:28:09 raspberrypi systemd[1]: Stopped go-librespot Daemon.
Sep 17 20:28:09 raspberrypi volumio[32564]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi systemd[1]: Started go-librespot Daemon.
Sep 17 20:28:09 raspberrypi sudo[32728]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:09 raspberrypi go-librespot[32730]: go-librespot daemon starting...
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=info msg="running go-librespot 0.3.2"
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=debug msg="app state loaded"
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=debug msg="stored credentials not found"
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: No need to fix Spotify hosts
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Sep 17 20:28:09 raspberrypi go-librespot[32730]: time="2025-09-17T20:28:09+02:00" level=info msg="zeroconf server listening on port 37269"
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Starting Shairport Sync
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Starting Shairport Sync
Sep 17 20:28:09 raspberrypi sudo[32747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Starting Shairport Sync
Sep 17 20:28:09 raspberrypi sudo[32747]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:09 raspberrypi sudo[32749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:28:09 raspberrypi sudo[32749]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::volumioGetState
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CorePlayQueue::getTrack 0
Sep 17 20:28:09 raspberrypi sudo[32753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:28:09 raspberrypi sudo[32753]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:09 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:28:09 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:28:09 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Output device has changed, restarting MPD
Sep 17 20:28:09 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:28:09 raspberrypi sudo[32757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 20:28:09 raspberrypi sudo[32747]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Output device has changed, restarting Shairport Sync
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:09 raspberrypi sudo[32749]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:09 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:28:09 raspberrypi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:28:09 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:28:09 raspberrypi sudo[32757]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:09 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:28:09 raspberrypi sudo[32757]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:09 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:28:09 raspberrypi sudo[32753]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:09 raspberrypi volumio[32564]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 20:28:09 raspberrypi sudo[32759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 20:28:09 raspberrypi sudo[32759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:09 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:09 raspberrypi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Sep 17 20:28:09 raspberrypi systemd[1]: mpd.service: Succeeded.
Sep 17 20:28:09 raspberrypi systemd[1]: Stopped Music Player Daemon.
Sep 17 20:28:10 raspberrypi volumio[32564]: info: MPD Permissions set
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Shairport-Sync Started
Sep 17 20:28:10 raspberrypi volumio[32564]: Error adding Membership: Error: addMembership EINVAL
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Shairport-Sync Started
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Shairport-Sync Started
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi systemd[1]: Starting Music Player Daemon...
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Starting Shairport Sync
Sep 17 20:28:10 raspberrypi sudo[307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 20:28:10 raspberrypi sudo[307]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:10 raspberrypi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 20:28:10 raspberrypi systemd[1]: shairport-sync.service: Succeeded.
Sep 17 20:28:10 raspberrypi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:28:10 raspberrypi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 20:28:10 raspberrypi sudo[307]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Shairport-Sync Started
Sep 17 20:28:10 raspberrypi sudo[301]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 17 20:28:10 raspberrypi sudo[301]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:10 raspberrypi sudo[301]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:10 raspberrypi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Sep 17 20:28:10 raspberrypi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 51.
Sep 17 20:28:10 raspberrypi systemd[1]: Stopped FusionDsp Daemon.
Sep 17 20:28:10 raspberrypi systemd[1]: Started FusionDsp Daemon.
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 20:28:10 raspberrypi volumio[32564]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:28:10 raspberrypi volumio[32564]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Sep 17 20:28:10 raspberrypi volumio[32564]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Sep 17 20:28:10 raspberrypi volumio[32564]: info: camilladsp service started and running in background, instance 1
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 20:28:10 raspberrypi volumio[32564]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:28:10 raspberrypi volumio[32564]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Sep 17 20:28:10 raspberrypi volumio[32564]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 17 20:28:10 raspberrypi volumio[32564]: info: FusionDsp loaded
Sep 17 20:28:10 raspberrypi volumio[32564]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 20:28:10 raspberrypi sudo[328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 17 20:28:10 raspberrypi sudo[328]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:10 raspberrypi volumio[32564]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Adding Signal Path Element [object Object]
Sep 17 20:28:10 raspberrypi volumio[32564]: info: Adding fusiondspeq DSP Signal Path Element
Sep 17 20:28:10 raspberrypi volumio[32564]: info: FusionDsp - ---- installed callbackRead
Sep 17 20:28:10 raspberrypi volumio[32564]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:28:10 raspberrypi sudo[328]: pam_unix(sudo:session): session closed for user root
Sep 17 20:28:10 raspberrypi volumio[32564]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 17 20:28:10 raspberrypi volumio[32564]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 17 20:28:10 raspberrypi volumio[32564]: at onErrorNT (internal/child_process.js:465:16)
Sep 17 20:28:10 raspberrypi volumio[32564]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Sep 17 20:28:10 raspberrypi volumio[32564]: errno: -2,
Sep 17 20:28:10 raspberrypi volumio[32564]: code: 'ENOENT',
Sep 17 20:28:10 raspberrypi volumio[32564]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:28:10 raspberrypi volumio[32564]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 17 20:28:10 raspberrypi volumio[32564]: spawnargs: [
Sep 17 20:28:10 raspberrypi volumio[32564]: '-p',
Sep 17 20:28:10 raspberrypi volumio[32564]: 9876,
Sep 17 20:28:10 raspberrypi volumio[32564]: '-o',
Sep 17 20:28:10 raspberrypi volumio[32564]: '/tmp/camilladsp.log',
Sep 17 20:28:10 raspberrypi volumio[32564]: '-l',
Sep 17 20:28:10 raspberrypi volumio[32564]: 'warn',
Sep 17 20:28:10 raspberrypi volumio[32564]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 17 20:28:10 raspberrypi volumio[32564]: ]
Sep 17 20:28:10 raspberrypi volumio[32564]: }
Sep 17 20:28:10 raspberrypi volumio[32564]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 20:28:11 raspberrypi volumio[313]: Traceback (most recent call last):
Sep 17 20:28:11 raspberrypi volumio[313]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in
Sep 17 20:28:11 raspberrypi volumio[313]: from camilladsp import CamillaConnection
Sep 17 20:28:11 raspberrypi volumio[313]: ModuleNotFoundError: No module named 'camilladsp'
Sep 17 20:28:11 raspberrypi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 20:28:11 raspberrypi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Sep 17 20:28:11 raspberrypi sudo[340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 20:27
Sep 17 20:28:11 raspberrypi sudo[340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 20:28:11 raspberrypi mpd[311]: Sep 17 20:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
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"