Dec 09 11:21:27 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Dec 09 11:21:27 volumio volumio[1270]: info: CorePlayQueue::getTrack 6 Dec 09 11:21:37 volumio volumio[1270]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 11:21:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 09 11:21:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 11:21:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 09 11:21:37 volumio volumio[1270]: info: Getting Alsa Cards List without I2S DAC Dec 09 11:21:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 09 11:21:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 09 11:21:38 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 09 11:21:56 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Dec 09 11:21:56 volumio volumio[1270]: info: CorePlayQueue::getTrack 6 Dec 09 11:21:58 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 09 11:21:58 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 09 11:22:05 volumio volumio[1270]: info: Starting Uninstall of plugin audio_interface - fusiondsp Dec 09 11:22:05 volumio volumio[1270]: info: Uninstalling plugin fusiondsp Dec 09 11:22:05 volumio volumio[1270]: info: FusionDsp - Stopping clipped samples monitor Dec 09 11:22:05 volumio volumio[1270]: info: FusionDsp - Clipped samples monitor stopped Dec 09 11:22:05 volumio volumio[1270]: info: FusionDsp - Stopping FusionDsp service Dec 09 11:22:05 volumio volumio[1270]: info: camilladsp stopping service pid 7537... Dec 09 11:22:05 volumio volumio[1270]: info: camilladsp service terminated, instance 2 Dec 09 11:22:05 volumio volumio[1270]: info: Disabling plugin fusiondsp Dec 09 11:22:05 volumio volumio[1270]: info: Preparing to generate the ALSA configuration file Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::volumioPause Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::pause Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::stPlaybackTimer Dec 09 11:22:05 volumio sudo[7549]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Dec 09 11:22:05 volumio sudo[7549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::servicePause Dec 09 11:22:05 volumio volumio[1270]: info: CorePlayQueue::getTrack 6 Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::servicePause Dec 09 11:22:05 volumio volumio[1270]: info: ControllerMpd::pause Dec 09 11:22:05 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand pause Dec 09 11:22:05 volumio volumio[1270]: info: Dec 09 11:22:05 volumio volumio[1270]: ---------------------------- MPD announces state update: player Dec 09 11:22:05 volumio volumio[1270]: info: sendMpdCommand pause took 3 milliseconds Dec 09 11:22:05 volumio volumio[1270]: info: ControllerMpd::getState Dec 09 11:22:05 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand status Dec 09 11:22:05 volumio volumio[1270]: info: sendMpdCommand status took 1 milliseconds Dec 09 11:22:05 volumio volumio[1270]: verbose: ControllerMpd::parseState Dec 09 11:22:05 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 09 11:22:05 volumio volumio[1270]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 09 11:22:05 volumio volumio[1270]: verbose: ControllerMpd::parseTrackInfo Dec 09 11:22:05 volumio volumio[1270]: info: ControllerMpd::pushState Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Dec 09 11:22:05 volumio volumio[1270]: info: CorePlayQueue::getTrack 6 Dec 09 11:22:05 volumio volumio[1270]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":89201,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Adele - Rolling in the Deep (Official Music Video).mp3","artist":"Adele","album":null,"uri":"INTERNAL/Adele - Rolling in the Deep (Official Music Video).mp3","trackType":"mp3"} Dec 09 11:22:05 volumio volumio[1270]: verbose: CURRENT POSITION 6 Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::syncState stateService pause Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::syncState currentStatus pause Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 09 11:22:05 volumio volumio[1270]: info: CorePlayQueue::getTrack 6 Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 09 11:22:05 volumio volumio[1270]: info: CoreStateMachine::stPlaybackTimer Dec 09 11:22:05 volumio volumio[1270]: info: ------------------------------ 5ms Dec 09 11:22:05 volumio volumio[1270]: info: FusionDsp - Volumio is not playing Dec 09 11:22:05 volumio volumio[1270]: info: FusionDsp - Clipped samples monitor stopped Dec 09 11:22:05 volumio volumio[1270]: info: Asound.conf file written Dec 09 11:22:05 volumio systemd[1]: Stopping fusiondsp.service - FusionDsp Daemon... Dec 09 11:22:05 volumio volumio[23073]: ======== Running on http://0.0.0.0:5011 ======== Dec 09 11:22:05 volumio volumio[23073]: (Press CTRL+C to quit) Dec 09 11:22:05 volumio sudo[7553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 09 11:22:05 volumio sudo[7553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 09 11:22:05 volumio sudo[7553]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:05 volumio volumio[1270]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 09 11:22:05 volumio volumio[1270]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 09 11:22:05 volumio volumio[1270]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Dec 09 11:22:05 volumio volumio[1270]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Dec 09 11:22:05 volumio volumio[1270]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Dec 09 11:22:05 volumio volumio[1270]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Dec 09 11:22:05 volumio volumio[1270]: info: Output device has changed, restarting MPD Dec 09 11:22:05 volumio volumio[1270]: info: Output device has changed, restarting Shairport Sync Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio sudo[7561]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 11:22:05 volumio sudo[7563]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 09 11:22:05 volumio sudo[7563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 09 11:22:05 volumio sudo[7561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 09 11:22:05 volumio sudo[7561]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:05 volumio volumio[1270]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 09 11:22:05 volumio volumio[1270]: info: Checking if uninstall.sh is present Dec 09 11:22:05 volumio volumio[1270]: info: Executing uninstall.sh Dec 09 11:22:05 volumio volumio[1270]: info: MPD Permissions set Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 09 11:22:05 volumio sudo[7572]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Dec 09 11:22:05 volumio sudo[7572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 09 11:22:05 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 11:22:05 volumio volumio[1270]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Dec 09 11:22:05 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Dec 09 11:22:05 volumio volumio[1270]: info: CorePlayQueue::getTrack 6 Dec 09 11:22:05 volumio volumio[1270]: info: mpdhttpout --- Volumio set on pause Dec 09 11:22:05 volumio volumio[1270]: info: Starting Shairport Sync Dec 09 11:22:05 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 09 11:22:05 volumio systemd[1]: mpd.service: Consumed 1.234s CPU time. Dec 09 11:22:05 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 09 11:22:05 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 09 11:22:05 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 09 11:22:05 volumio sudo[7583]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 09 11:22:05 volumio sudo[7583]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 09 11:22:05 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 09 11:22:05 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 09 11:22:05 volumio systemd[1]: fusiondsp.service: Deactivated successfully. Dec 09 11:22:05 volumio systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon. Dec 09 11:22:05 volumio systemd[1]: fusiondsp.service: Consumed 1.196s CPU time. Dec 09 11:22:05 volumio sudo[7549]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:05 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 09 11:22:05 volumio volumio[1270]: info: FusionDsp - Reporting Fusion DSP Disabled Dec 09 11:22:05 volumio volumio[1270]: info: Removing fusiondspeq DSP Signal Path Element Dec 09 11:22:05 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 09 11:22:05 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 09 11:22:05 volumio systemd[1]: shairport-sync.service: Consumed 1.792s CPU time. Dec 09 11:22:05 volumio sudo[7586]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/fusiondsp.service Dec 09 11:22:05 volumio sudo[7586]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 09 11:22:05 volumio sudo[7586]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:05 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 09 11:22:05 volumio sudo[7588]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Dec 09 11:22:05 volumio sudo[7583]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:05 volumio sudo[7588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 09 11:22:05 volumio volumio[1270]: info: Shairport-Sync Started Dec 09 11:22:05 volumio systemd[1]: Reloading. Dec 09 11:22:05 volumio sudo[7585]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 09 11:22:05 volumio sudo[7585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 09 11:22:05 volumio sudo[7585]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:06 volumio sudo[7588]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:06 volumio sudo[7572]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:06 volumio volumio[1270]: info: Uninstall script completed Dec 09 11:22:06 volumio volumio[1270]: info: Removing plugin fusiondsp from configuration Dec 09 11:22:06 volumio volumio[1270]: info: Successfully removed fusiondsp configuration files Dec 09 11:22:06 volumio volumio[1270]: info: Plugin folders cleanup Dec 09 11:22:06 volumio volumio[1270]: info: Scanning into folder /volumio/app/plugins/ Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category audio_interface Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category miscellanea Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category music_service Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category plugins.json Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category system_controller Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category user_interface Dec 09 11:22:06 volumio volumio[1270]: info: Scanning into folder /data/plugins/ Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category audio_interface Dec 09 11:22:06 volumio volumio[1270]: info: Cleaning folder for fusiondsp Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category music_service Dec 09 11:22:06 volumio volumio[1270]: info: Scanning category system_hardware Dec 09 11:22:06 volumio volumio[1270]: info: Plugin folders cleanup completed Dec 09 11:22:06 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 09 11:22:06 volumio volumio[1270]: info: [{"prettyName":"pandora","name":"pandora","category":"music_service","version":"3.13.1","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Bluetooth_Remote","name":"Bluetoothremote","category":"system_hardware","version":"0.0.13","icon":"fa-bluetooth","isManuallyInstalled":false,"enabled":true,"active":true}] Dec 09 11:22:06 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 09 11:22:06 volumio volumio[1270]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 09 11:22:06 volumio volumio[1270]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Dec 09 11:22:06 volumio volumio[1270]: at ChildProcess._handle.onexit (node:internal/child_process:286:19) Dec 09 11:22:06 volumio volumio[1270]: at onErrorNT (node:internal/child_process:484:16) Dec 09 11:22:06 volumio volumio[1270]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Dec 09 11:22:06 volumio volumio[1270]: errno: -2, Dec 09 11:22:06 volumio volumio[1270]: code: 'ENOENT', Dec 09 11:22:06 volumio volumio[1270]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Dec 09 11:22:06 volumio volumio[1270]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Dec 09 11:22:06 volumio volumio[1270]: spawnargs: [ Dec 09 11:22:06 volumio volumio[1270]: '-p', Dec 09 11:22:06 volumio volumio[1270]: 9876, Dec 09 11:22:06 volumio volumio[1270]: '-o', Dec 09 11:22:06 volumio volumio[1270]: '/tmp/camilladsp.log', Dec 09 11:22:06 volumio volumio[1270]: '-l', Dec 09 11:22:06 volumio volumio[1270]: 'warn', Dec 09 11:22:06 volumio volumio[1270]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Dec 09 11:22:06 volumio volumio[1270]: ] Dec 09 11:22:06 volumio volumio[1270]: } Dec 09 11:22:06 volumio volumio[1270]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 09 11:22:06 volumio mpd[7623]: 2025-12-09T11:22:06 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 09 11:22:06 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 09 11:22:06 volumio sudo[7563]: pam_unix(sudo:session): session closed for user root Dec 09 11:22:06 volumio sudo[7661]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-09 11:21' Dec 09 11:22:06 volumio sudo[7661]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"