-- Logs begin at Sat 2024-08-31 13:20:27 CEST, end at Sat 2024-08-31 13:53:48 CEST. -- Aug 31 13:53:36 volumio-socrates sudo[30146]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params Aug 31 13:53:36 volumio-socrates sudo[30146]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:36 volumio-socrates sudo[30146]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:36 volumio-socrates sudo[30148]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Aug 31 13:53:36 volumio-socrates sudo[30148]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:36 volumio-socrates sudo[30148]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:36 volumio-socrates sudo[30150]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Aug 31 13:53:36 volumio-socrates sudo[30150]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:37 volumio-socrates volumio[29141]: info: Reading package lists... Aug 31 13:53:37 volumio-socrates volumio[29141]: info: Building dependency tree... Aug 31 13:53:37 volumio-socrates volumio[29141]: info: Reading state information... Aug 31 13:53:39 volumio-socrates volumio[29141]: info: drc is already the newest version (3.2.2~dfsg0-2). Aug 31 13:53:39 volumio-socrates sudo[30150]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:39 volumio-socrates sudo[29611]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:39 volumio-socrates volumio[29141]: info: 0 upgraded, 0 newly installed, 0 to remove and 13 not upgraded. Aug 31 13:53:39 volumio-socrates volumio[29141]: info: Install script completed Aug 31 13:53:39 volumio-socrates volumio[29141]: info: Adding reference to registry Aug 31 13:53:39 volumio-socrates volumio[29141]: info: Done installing plugin. Aug 31 13:53:39 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 13:53:39 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 31 13:53:39 volumio-socrates volumio[29141]: info: Folder /tmp/plugins removed Aug 31 13:53:39 volumio-socrates volumio[29141]: info: Folder /tmp/downloaded_plugin.zip removed Aug 31 13:53:39 volumio-socrates volumio[29141]: Plugin install end detected on script Aug 31 13:53:39 volumio-socrates volumio[29141]: info: Folder /data/temp removed Aug 31 13:53:44 volumio-socrates volumio[29141]: info: Enabling plugin fusiondsp Aug 31 13:53:44 volumio-socrates volumio[29141]: info: Loading plugin "fusiondsp"... Aug 31 13:53:44 volumio-socrates volumio[29141]: info: Applying required configuration parameters for plugin fusiondsp Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Preparing to generate the ALSA configuration file Aug 31 13:53:45 volumio-socrates volumio[29141]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 31 13:53:45 volumio-socrates volumio[29141]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Reading ALSA contributions from plugins. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Asound.conf file written Aug 31 13:53:45 volumio-socrates sudo[30155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 31 13:53:45 volumio-socrates sudo[30155]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:45 volumio-socrates sudo[30155]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Output device has changed, restarting MPD Aug 31 13:53:45 volumio-socrates sudo[30163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 13:53:45 volumio-socrates sudo[30163]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:45 volumio-socrates sudo[30163]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Output device has changed, restarting Shairport Sync Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 13:53:45 volumio-socrates sudo[30166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 13:53:45 volumio-socrates sudo[30166]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:45 volumio-socrates systemd[1]: Stopping Music Player Daemon... Aug 31 13:53:45 volumio-socrates systemd[1]: mpd.service: Succeeded. Aug 31 13:53:45 volumio-socrates systemd[1]: Stopped Music Player Daemon. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 13:53:45 volumio-socrates volumio[29141]: info: PLUGIN START: fusiondsp Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Loading i18n strings for locale en Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: FusionDsp - mixtype--------------------- Hardware Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Preparing to generate the ALSA configuration file Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Done. Aug 31 13:53:45 volumio-socrates systemd[1]: Starting Music Player Daemon... Aug 31 13:53:45 volumio-socrates volumio[29141]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 31 13:53:45 volumio-socrates volumio[29141]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Reading ALSA contributions from plugins. Aug 31 13:53:45 volumio-socrates volumio[29141]: info: MPD Permissions set Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::volumioGetState Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CorePlayQueue::getTrack 0 Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 13:53:45 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:45 volumio-socrates sudo[30171]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 13:53:45 volumio-socrates sudo[30171]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:45 volumio-socrates sudo[30171]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:45 volumio-socrates volumio[29141]: info: Starting Shairport Sync Aug 31 13:53:45 volumio-socrates sudo[30183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 13:53:45 volumio-socrates sudo[30183]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:46 volumio-socrates systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 13:53:46 volumio-socrates systemd[1]: shairport-sync.service: Succeeded. Aug 31 13:53:46 volumio-socrates systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 13:53:46 volumio-socrates systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 13:53:46 volumio-socrates sudo[30183]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Shairport-Sync Started Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Asound.conf file unchanged, so no further update is needed Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Output device has changed, restarting MPD Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Output device has changed, restarting Shairport Sync Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 13:53:46 volumio-socrates sudo[30191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 13:53:46 volumio-socrates sudo[30191]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:46 volumio-socrates sudo[30191]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:46 volumio-socrates sudo[30194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 13:53:46 volumio-socrates sudo[30194]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:46 volumio-socrates systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 31 13:53:46 volumio-socrates systemd[1]: mpd.service: Succeeded. Aug 31 13:53:46 volumio-socrates systemd[1]: Stopped Music Player Daemon. Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 13:53:46 volumio-socrates volumio[29141]: info: MPD Permissions set Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates systemd[1]: Starting Music Player Daemon... Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Starting Shairport Sync Aug 31 13:53:46 volumio-socrates sudo[30200]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 13:53:46 volumio-socrates sudo[30200]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:46 volumio-socrates sudo[30200]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:46 volumio-socrates sudo[30208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 13:53:46 volumio-socrates sudo[30208]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:46 volumio-socrates systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 13:53:46 volumio-socrates systemd[1]: shairport-sync.service: Succeeded. Aug 31 13:53:46 volumio-socrates systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 13:53:46 volumio-socrates systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 13:53:46 volumio-socrates sudo[30208]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:46 volumio-socrates volumio[29141]: info: Shairport-Sync Started Aug 31 13:53:47 volumio-socrates volumio[29141]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 31 13:53:47 volumio-socrates volumio[29141]: 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 Aug 31 13:53:47 volumio-socrates volumio[29141]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 31 13:53:47 volumio-socrates volumio[29141]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 31 13:53:47 volumio-socrates volumio[29141]: info: camilladsp service started and running in background, instance 1 Aug 31 13:53:47 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 13:53:47 volumio-socrates volumio[29141]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Aug 31 13:53:47 volumio-socrates volumio[29141]: info: FusionDsp loaded Aug 31 13:53:47 volumio-socrates volumio[29141]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 13:53:47 volumio-socrates sudo[30225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 31 13:53:47 volumio-socrates sudo[30225]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 13:53:47 volumio-socrates volumio[29141]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 31 13:53:47 volumio-socrates volumio[29141]: info: Adding Signal Path Element [object Object] Aug 31 13:53:47 volumio-socrates volumio[29141]: info: Adding fusiondspeq DSP Signal Path Element Aug 31 13:53:47 volumio-socrates volumio[29141]: info: FusionDsp - ---- installed callbackRead Aug 31 13:53:47 volumio-socrates volumio[29141]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 13:53:47 volumio-socrates sudo[30225]: pam_unix(sudo:session): session closed for user root Aug 31 13:53:47 volumio-socrates volumio[29141]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 31 13:53:47 volumio-socrates volumio[29141]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 31 13:53:47 volumio-socrates volumio[29141]: at onErrorNT (internal/child_process.js:465:16) Aug 31 13:53:47 volumio-socrates volumio[29141]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 31 13:53:47 volumio-socrates volumio[29141]: errno: -2, Aug 31 13:53:47 volumio-socrates volumio[29141]: code: 'ENOENT', Aug 31 13:53:47 volumio-socrates volumio[29141]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 31 13:53:47 volumio-socrates volumio[29141]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 31 13:53:47 volumio-socrates volumio[29141]: spawnargs: [ Aug 31 13:53:47 volumio-socrates volumio[29141]: '-p', Aug 31 13:53:47 volumio-socrates volumio[29141]: 9876, Aug 31 13:53:47 volumio-socrates volumio[29141]: '-o', Aug 31 13:53:47 volumio-socrates volumio[29141]: '/tmp/camilladsp.log', Aug 31 13:53:47 volumio-socrates volumio[29141]: '-l', Aug 31 13:53:47 volumio-socrates volumio[29141]: 'warn', Aug 31 13:53:47 volumio-socrates volumio[29141]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 31 13:53:47 volumio-socrates volumio[29141]: ] Aug 31 13:53:47 volumio-socrates volumio[29141]: } Aug 31 13:53:47 volumio-socrates volumio[29141]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 13:53:48 volumio-socrates sudo[30236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-31 13:52 Aug 31 13:53:48 volumio-socrates sudo[30236]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"