-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-11-01 17:29:21 CET. -- Nov 01 17:28:02 volumio volumio[930]: info: Selecting previously unselected package cpp. Nov 01 17:28:02 volumio volumio[930]: info: Preparing to unpack .../05-cpp_4%3a8.3.0-1+rpi2_armhf.deb ... Nov 01 17:28:02 volumio volumio[930]: info: Unpacking cpp (4:8.3.0-1+rpi2) ... Nov 01 17:28:03 volumio volumio[930]: info: Selecting previously unselected package libcc1-0:armhf. Nov 01 17:28:03 volumio volumio[930]: info: Preparing to unpack .../06-libcc1-0_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:03 volumio volumio[930]: info: Unpacking libcc1-0:armhf (8.3.0-6+rpi1) ... Nov 01 17:28:03 volumio volumio[930]: info: Selecting previously unselected package libasan5:armhf. Nov 01 17:28:03 volumio volumio[930]: info: Preparing to unpack .../07-libasan5_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:04 volumio volumio[930]: info: Unpacking libasan5:armhf (8.3.0-6+rpi1) ... Nov 01 17:28:04 volumio volumio[930]: info: Selecting previously unselected package libubsan1:armhf. Nov 01 17:28:04 volumio volumio[930]: info: Preparing to unpack .../08-libubsan1_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:04 volumio volumio[930]: info: Unpacking libubsan1:armhf (8.3.0-6+rpi1) ... Nov 01 17:28:04 volumio volumio[930]: info: Selecting previously unselected package libgcc-8-dev:armhf. Nov 01 17:28:04 volumio volumio[930]: info: Preparing to unpack .../09-libgcc-8-dev_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:04 volumio volumio[930]: info: Unpacking libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Nov 01 17:28:06 volumio volumio[930]: info: Selecting previously unselected package gcc-8. Nov 01 17:28:06 volumio volumio[930]: info: Preparing to unpack .../10-gcc-8_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:06 volumio volumio[930]: info: Unpacking gcc-8 (8.3.0-6+rpi1) ... Nov 01 17:28:09 volumio volumio[930]: info: Selecting previously unselected package gcc. Nov 01 17:28:09 volumio volumio[930]: info: Preparing to unpack .../11-gcc_4%3a8.3.0-1+rpi2_armhf.deb ... Nov 01 17:28:09 volumio volumio[930]: info: Unpacking gcc (4:8.3.0-1+rpi2) ... Nov 01 17:28:09 volumio volumio[930]: info: Selecting previously unselected package libstdc++-8-dev:armhf. Nov 01 17:28:09 volumio volumio[930]: info: Preparing to unpack .../12-libstdc++-8-dev_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:09 volumio volumio[930]: info: Unpacking libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Nov 01 17:28:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 01 17:28:23 volumio volumio[930]: info: Selecting previously unselected package g++-8. Nov 01 17:28:23 volumio volumio[930]: info: Preparing to unpack .../13-g++-8_8.3.0-6+rpi1_armhf.deb ... Nov 01 17:28:23 volumio volumio[930]: info: Unpacking g++-8 (8.3.0-6+rpi1) ... Nov 01 17:28:29 volumio volumio[930]: info: Selecting previously unselected package g++. Nov 01 17:28:29 volumio volumio[930]: info: Preparing to unpack .../14-g++_4%3a8.3.0-1+rpi2_armhf.deb ... Nov 01 17:28:29 volumio volumio[930]: info: Unpacking g++ (4:8.3.0-1+rpi2) ... Nov 01 17:28:29 volumio volumio[930]: info: Selecting previously unselected package make. Nov 01 17:28:29 volumio volumio[930]: info: Preparing to unpack .../15-make_4.2.1-1.2_armhf.deb ... Nov 01 17:28:29 volumio volumio[930]: info: Unpacking make (4.2.1-1.2) ... Nov 01 17:28:30 volumio volumio[930]: info: Selecting previously unselected package patch. Nov 01 17:28:30 volumio volumio[930]: info: Preparing to unpack .../16-patch_2.7.6-3+deb10u1_armhf.deb ... Nov 01 17:28:30 volumio volumio[930]: info: Unpacking patch (2.7.6-3+deb10u1) ... Nov 01 17:28:30 volumio volumio[930]: info: Selecting previously unselected package dpkg-dev. Nov 01 17:28:30 volumio volumio[930]: info: Preparing to unpack .../17-dpkg-dev_1.19.8_all.deb ... Nov 01 17:28:30 volumio volumio[930]: info: Unpacking dpkg-dev (1.19.8) ... Nov 01 17:28:33 volumio volumio[930]: info: Selecting previously unselected package build-essential. Nov 01 17:28:33 volumio volumio[930]: info: Preparing to unpack .../18-build-essential_12.6_armhf.deb ... Nov 01 17:28:34 volumio volumio[930]: info: Unpacking build-essential (12.6) ... Nov 01 17:28:34 volumio volumio[930]: info: Selecting previously unselected package dh-python. Nov 01 17:28:34 volumio volumio[930]: info: Preparing to unpack .../19-dh-python_3.20190308_all.deb ... Nov 01 17:28:34 volumio volumio[930]: info: Unpacking dh-python (3.20190308) ... Nov 01 17:28:35 volumio volumio[930]: info: Selecting previously unselected package libfakeroot:armhf. Nov 01 17:28:35 volumio volumio[930]: info: Preparing to unpack .../20-libfakeroot_1.23-1_armhf.deb ... Nov 01 17:28:35 volumio volumio[930]: info: Unpacking libfakeroot:armhf (1.23-1) ... Nov 01 17:28:35 volumio volumio[930]: info: Selecting previously unselected package fakeroot. Nov 01 17:28:35 volumio volumio[930]: info: Preparing to unpack .../21-fakeroot_1.23-1_armhf.deb ... Nov 01 17:28:35 volumio volumio[930]: info: Unpacking fakeroot (1.23-1) ... Nov 01 17:28:36 volumio volumio[930]: info: Selecting previously unselected package libalgorithm-diff-perl. Nov 01 17:28:36 volumio volumio[930]: info: Preparing to unpack .../22-libalgorithm-diff-perl_1.19.03-2_all.deb ... Nov 01 17:28:36 volumio volumio[930]: info: Unpacking libalgorithm-diff-perl (1.19.03-2) ... Nov 01 17:28:38 volumio volumio[930]: info: Selecting previously unselected package libalgorithm-diff-xs-perl. Nov 01 17:28:38 volumio volumio[930]: info: Preparing to unpack .../23-libalgorithm-diff-xs-perl_0.04-5+b1_armhf.deb ... Nov 01 17:28:38 volumio volumio[930]: info: Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ... Nov 01 17:28:38 volumio volumio[930]: info: Selecting previously unselected package libalgorithm-merge-perl. Nov 01 17:28:38 volumio volumio[930]: info: Preparing to unpack .../24-libalgorithm-merge-perl_0.08-3_all.deb ... Nov 01 17:28:38 volumio volumio[930]: info: Unpacking libalgorithm-merge-perl (0.08-3) ... Nov 01 17:28:38 volumio volumio[930]: info: Selecting previously unselected package libexpat1-dev:armhf. Nov 01 17:28:38 volumio volumio[930]: info: Preparing to unpack .../25-libexpat1-dev_2.2.6-2+deb10u7_armhf.deb ... Nov 01 17:28:38 volumio volumio[930]: info: Unpacking libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Nov 01 17:28:39 volumio volumio[930]: info: Selecting previously unselected package libpython3.7:armhf. Nov 01 17:28:39 volumio volumio[930]: info: Preparing to unpack .../26-libpython3.7_3.7.3-2+deb10u7_armhf.deb ... Nov 01 17:28:39 volumio volumio[930]: info: Unpacking libpython3.7:armhf (3.7.3-2+deb10u7) ... Nov 01 17:28:40 volumio volumio[930]: info: Selecting previously unselected package libpython3.7-dev:armhf. Nov 01 17:28:40 volumio volumio[930]: info: Preparing to unpack .../27-libpython3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Nov 01 17:28:40 volumio volumio[930]: info: Unpacking libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Nov 01 17:28:45 volumio volumio[930]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/remotepi/volumio/buster/armhf Nov 01 17:28:46 volumio volumio[930]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/remotepi/volumio/buster/armhf Nov 01 17:28:46 volumio volumio[930]: info: Folder /tmp/plugins removed Nov 01 17:28:47 volumio volumio[930]: info: Check plugin dependencies Nov 01 17:28:47 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 17:28:47 volumio volumio[930]: info: Checking if plugin already exists Nov 01 17:28:47 volumio volumio[930]: info: Rename folder Nov 01 17:28:47 volumio volumio[930]: info: Folder /tmp/downloaded_plugin.zip removed Nov 01 17:28:47 volumio volumio[930]: info: Move to category Nov 01 17:28:55 volumio volumio[930]: info: Checking if install.sh is present Nov 01 17:28:55 volumio volumio[930]: info: Executing install.sh Nov 01 17:28:56 volumio volumio[930]: info: Nov 01 17:28:56 volumio volumio[930]: Selecting previously unselected package libpython3-dev:armhf. Nov 01 17:28:56 volumio volumio[930]: info: Nov 01 17:28:56 volumio sudo[2980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/remotepi/install.sh Nov 01 17:28:56 volumio volumio[930]: Selecting previously unselected package libpython3-dev:armhf. Nov 01 17:28:56 volumio volumio[930]: info: Preparing to unpack .../28-libpython3-dev_3.7.3-1_armhf.deb ... Nov 01 17:28:56 volumio sudo[2980]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:28:56 volumio volumio[930]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ... Nov 01 17:28:56 volumio volumio[930]: info: Preparing to unpack .../28-libpython3-dev_3.7.3-1_armhf.deb ... Nov 01 17:28:56 volumio volumio[930]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ... Nov 01 17:28:56 volumio volumio[930]: info: Selecting previously unselected package python-pip-whl. Nov 01 17:28:56 volumio volumio[930]: info: Selecting previously unselected package python-pip-whl. Nov 01 17:28:56 volumio volumio[930]: info: Preparing to unpack .../29-python-pip-whl_18.1-5+rpt1_all.deb ... Nov 01 17:28:56 volumio volumio[930]: info: Unpacking python-pip-whl (18.1-5+rpt1) ... Nov 01 17:28:56 volumio volumio[930]: info: Preparing to unpack .../29-python-pip-whl_18.1-5+rpt1_all.deb ... Nov 01 17:28:56 volumio volumio[930]: info: Unpacking python-pip-whl (18.1-5+rpt1) ... Nov 01 17:28:57 volumio volumio[930]: info: Selecting previously unselected package python3-multidict. Nov 01 17:28:57 volumio volumio[930]: info: Selecting previously unselected package python3-multidict. Nov 01 17:28:57 volumio volumio[930]: info: Preparing to unpack .../30-python3-multidict_4.5.2-1_armhf.deb ... Nov 01 17:28:57 volumio volumio[930]: info: Unpacking python3-multidict (4.5.2-1) ... Nov 01 17:28:57 volumio volumio[930]: info: Preparing to unpack .../30-python3-multidict_4.5.2-1_armhf.deb ... Nov 01 17:28:57 volumio volumio[930]: info: Unpacking python3-multidict (4.5.2-1) ... Nov 01 17:28:57 volumio volumio[930]: info: Selecting previously unselected package python3-yarl. Nov 01 17:28:57 volumio volumio[930]: info: Selecting previously unselected package python3-yarl. Nov 01 17:28:57 volumio volumio[930]: info: Preparing to unpack .../31-python3-yarl_1.3.0-1_armhf.deb ... Nov 01 17:28:57 volumio volumio[930]: info: Unpacking python3-yarl (1.3.0-1) ... Nov 01 17:28:57 volumio volumio[930]: info: Preparing to unpack .../31-python3-yarl_1.3.0-1_armhf.deb ... Nov 01 17:28:57 volumio volumio[930]: info: Unpacking python3-yarl (1.3.0-1) ... Nov 01 17:28:58 volumio volumio[930]: info: Selecting previously unselected package python3-async-timeout. Nov 01 17:28:58 volumio volumio[930]: info: Selecting previously unselected package python3-async-timeout. Nov 01 17:28:58 volumio volumio[930]: info: Preparing to unpack .../32-python3-async-timeout_3.0.1-1_all.deb ... Nov 01 17:28:58 volumio volumio[930]: info: Unpacking python3-async-timeout (3.0.1-1) ... Nov 01 17:28:58 volumio volumio[930]: info: Preparing to unpack .../32-python3-async-timeout_3.0.1-1_all.deb ... Nov 01 17:28:58 volumio volumio[930]: info: Unpacking python3-async-timeout (3.0.1-1) ... Nov 01 17:28:58 volumio volumio[930]: info: Selecting previously unselected package python3-attr. Nov 01 17:28:58 volumio volumio[930]: info: Selecting previously unselected package python3-attr. Nov 01 17:28:58 volumio volumio[930]: info: Preparing to unpack .../33-python3-attr_18.2.0-1_all.deb ... Nov 01 17:28:58 volumio volumio[930]: info: Unpacking python3-attr (18.2.0-1) ... Nov 01 17:28:58 volumio volumio[930]: info: Preparing to unpack .../33-python3-attr_18.2.0-1_all.deb ... Nov 01 17:28:58 volumio volumio[930]: info: Unpacking python3-attr (18.2.0-1) ... Nov 01 17:28:58 volumio volumio[930]: info: Selecting previously unselected package python3-aiohttp. Nov 01 17:28:58 volumio volumio[930]: info: Selecting previously unselected package python3-aiohttp. Nov 01 17:28:58 volumio volumio[930]: info: Preparing to unpack .../34-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Nov 01 17:28:58 volumio volumio[930]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Nov 01 17:28:59 volumio volumio[930]: info: Preparing to unpack .../34-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Nov 01 17:28:59 volumio volumio[930]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Nov 01 17:29:01 volumio volumio[930]: info: Selecting previously unselected package python3-asn1crypto. Nov 01 17:29:01 volumio volumio[930]: info: Selecting previously unselected package python3-asn1crypto. Nov 01 17:29:01 volumio volumio[930]: info: Preparing to unpack .../35-python3-asn1crypto_0.24.0-1_all.deb ... Nov 01 17:29:01 volumio volumio[930]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Nov 01 17:29:01 volumio volumio[930]: info: Preparing to unpack .../35-python3-asn1crypto_0.24.0-1_all.deb ... Nov 01 17:29:01 volumio volumio[930]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Nov 01 17:29:02 volumio volumio[930]: info: Selecting previously unselected package python3-cffi-backend. Nov 01 17:29:02 volumio volumio[930]: info: Selecting previously unselected package python3-cffi-backend. Nov 01 17:29:02 volumio volumio[930]: info: Preparing to unpack .../36-python3-cffi-backend_1.12.2-1_armhf.deb ... Nov 01 17:29:02 volumio volumio[930]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Nov 01 17:29:02 volumio volumio[930]: info: Preparing to unpack .../36-python3-cffi-backend_1.12.2-1_armhf.deb ... Nov 01 17:29:02 volumio volumio[930]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Nov 01 17:29:02 volumio volumio[930]: info: Selecting previously unselected package python3-crypto. Nov 01 17:29:02 volumio volumio[930]: info: Selecting previously unselected package python3-crypto. Nov 01 17:29:03 volumio volumio[930]: info: Preparing to unpack .../37-python3-crypto_2.6.1-9+b1_armhf.deb ... Nov 01 17:29:03 volumio volumio[930]: info: Preparing to unpack .../37-python3-crypto_2.6.1-9+b1_armhf.deb ... Nov 01 17:29:03 volumio volumio[930]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Nov 01 17:29:03 volumio volumio[930]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Nov 01 17:29:06 volumio volumio[930]: info: Selecting previously unselected package python3-cryptography. Nov 01 17:29:06 volumio volumio[930]: info: Selecting previously unselected package python3-cryptography. Nov 01 17:29:06 volumio volumio[930]: info: Preparing to unpack .../38-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ... Nov 01 17:29:06 volumio volumio[930]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ... Nov 01 17:29:06 volumio volumio[930]: info: Preparing to unpack .../38-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ... Nov 01 17:29:06 volumio volumio[930]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ... Nov 01 17:29:06 volumio sudo[2980]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:06 volumio volumio[930]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/system_hardware/remotepi/install.sh > /tmp/installog Nov 01 17:29:06 volumio volumio[930]: [sudo] password for volumio: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 01 17:29:06 volumio volumio[930]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 01 17:29:06 volumio volumio[930]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 01 17:29:06 volumio volumio[930]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 01 17:29:06 volumio volumio[930]: info: An error occurred installing the plugin. Rolling back config Nov 01 17:29:06 volumio volumio[930]: info: Plugin folders cleanup Nov 01 17:29:06 volumio volumio[930]: info: Scanning into folder /volumio/app/plugins/ Nov 01 17:29:06 volumio volumio[930]: info: Scanning category audio_interface Nov 01 17:29:06 volumio volumio[930]: info: Scanning category miscellanea Nov 01 17:29:06 volumio volumio[930]: info: Scanning category music_service Nov 01 17:29:06 volumio volumio[930]: info: Scanning category plugins.json Nov 01 17:29:06 volumio volumio[930]: info: Scanning category system_controller Nov 01 17:29:06 volumio volumio[930]: info: Scanning category user_interface Nov 01 17:29:06 volumio volumio[930]: info: Scanning into folder /data/plugins/ Nov 01 17:29:06 volumio volumio[930]: info: Scanning category audio_interface Nov 01 17:29:06 volumio volumio[930]: info: Scanning category system_hardware Nov 01 17:29:06 volumio volumio[930]: info: Plugin folders cleanup completed Nov 01 17:29:06 volumio volumio[930]: info: Error: Error Nov 01 17:29:06 volumio volumio[930]: info: Folder /tmp/plugins removed Nov 01 17:29:06 volumio volumio[930]: info: Folder /tmp/downloaded_plugin.zip removed Nov 01 17:29:07 volumio volumio[930]: info: Folder /data/temp removed Nov 01 17:29:13 volumio volumio[930]: info: Enabling plugin fusiondsp Nov 01 17:29:13 volumio volumio[930]: info: Loading plugin "fusiondsp"... Nov 01 17:29:17 volumio volumio[930]: info: Preparing to generate the ALSA configuration file Nov 01 17:29:17 volumio volumio[930]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:29:17 volumio volumio[930]: info: Selecting previously unselected package python3-dbus. Nov 01 17:29:17 volumio volumio[930]: info: Preparing to unpack .../39-python3-dbus_1.2.8-3_armhf.deb ... Nov 01 17:29:17 volumio volumio[930]: info: Unpacking python3-dbus (1.2.8-3) ... Nov 01 17:29:17 volumio volumio[930]: info: Selecting previously unselected package python3-dbus. Nov 01 17:29:17 volumio volumio[930]: info: Preparing to unpack .../39-python3-dbus_1.2.8-3_armhf.deb ... Nov 01 17:29:17 volumio volumio[930]: info: Unpacking python3-dbus (1.2.8-3) ... Nov 01 17:29:17 volumio volumio[930]: info: Asound.conf file unchanged, so no further update is needed Nov 01 17:29:17 volumio volumio[930]: info: Output device has changed, restarting MPD Nov 01 17:29:17 volumio volumio[930]: info: Output device has changed, restarting Shairport Sync Nov 01 17:29:17 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:17 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:29:17 volumio sudo[3356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 17:29:17 volumio sudo[3356]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:17 volumio sudo[3356]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:17 volumio sudo[3358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 17:29:17 volumio sudo[3358]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:18 volumio systemd[1]: Stopping Music Player Daemon... Nov 01 17:29:18 volumio volumio[930]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 17:29:18 volumio volumio[930]: info: PLUGIN START: fusiondsp Nov 01 17:29:18 volumio volumio[930]: info: Loading i18n strings for locale it Nov 01 17:29:18 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 01 17:29:18 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:18 volumio volumio[930]: info: FusionDsp - mixtype--------------------- None Nov 01 17:29:18 volumio volumio[930]: info: Preparing to generate the ALSA configuration file Nov 01 17:29:18 volumio volumio[930]: info: Done. Nov 01 17:29:18 volumio volumio[930]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 01 17:29:18 volumio volumio[930]: info: Reading ALSA contributions from plugins. Nov 01 17:29:18 volumio systemd[1]: mpd.service: Succeeded. Nov 01 17:29:18 volumio systemd[1]: Stopped Music Player Daemon. Nov 01 17:29:18 volumio systemd[1]: Starting Music Player Daemon... Nov 01 17:29:18 volumio sudo[3373]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 01 17:29:18 volumio sudo[3373]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:18 volumio sudo[3373]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:19 volumio volumio[930]: info: MPD Permissions set Nov 01 17:29:19 volumio volumio[930]: info: Selecting previously unselected package python3.7-dev. Nov 01 17:29:19 volumio volumio[930]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Nov 01 17:29:19 volumio volumio[930]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Nov 01 17:29:19 volumio volumio[930]: info: Selecting previously unselected package python3-dev. Nov 01 17:29:19 volumio volumio[930]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Nov 01 17:29:19 volumio volumio[930]: info: Unpacking python3-dev (3.7.3-1) ... Nov 01 17:29:19 volumio volumio[930]: info: Selecting previously unselected package python3.7-dev. Nov 01 17:29:19 volumio volumio[930]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Nov 01 17:29:19 volumio volumio[930]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Nov 01 17:29:19 volumio volumio[930]: info: Selecting previously unselected package python3-dev. Nov 01 17:29:19 volumio volumio[930]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Nov 01 17:29:19 volumio volumio[930]: info: Unpacking python3-dev (3.7.3-1) ... Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:19 volumio volumio[930]: info: Selecting previously unselected package python3-entrypoints. Nov 01 17:29:19 volumio volumio[930]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Nov 01 17:29:19 volumio volumio[930]: info: Unpacking python3-entrypoints (0.3-1) ... Nov 01 17:29:19 volumio volumio[930]: info: Selecting previously unselected package python3-entrypoints. Nov 01 17:29:19 volumio volumio[930]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Nov 01 17:29:19 volumio volumio[930]: info: Unpacking python3-entrypoints (0.3-1) ... Nov 01 17:29:19 volumio volumio[930]: info: Starting Shairport Sync Nov 01 17:29:19 volumio volumio[930]: info: Asound.conf file written Nov 01 17:29:19 volumio sudo[3409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 01 17:29:19 volumio sudo[3411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 01 17:29:19 volumio sudo[3411]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:19 volumio sudo[3409]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:19 volumio sudo[3411]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 01 17:29:19 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 01 17:29:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 01 17:29:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 01 17:29:20 volumio sudo[3409]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:20 volumio volumio[930]: info: Output device has changed, restarting MPD Nov 01 17:29:20 volumio volumio[930]: info: Output device has changed, restarting Shairport Sync Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:29:20 volumio sudo[3424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 17:29:20 volumio sudo[3424]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:20 volumio sudo[3424]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:20 volumio sudo[3426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 17:29:20 volumio sudo[3426]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:20 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 01 17:29:20 volumio systemd[1]: mpd.service: Succeeded. Nov 01 17:29:20 volumio systemd[1]: Stopped Music Player Daemon. Nov 01 17:29:20 volumio volumio[930]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 17:29:20 volumio volumio[930]: info: MPD Permissions set Nov 01 17:29:20 volumio volumio[930]: info: Shairport-Sync Started Nov 01 17:29:20 volumio volumio[930]: info: Selecting previously unselected package python3-gi. Nov 01 17:29:20 volumio systemd[1]: Starting Music Player Daemon... Nov 01 17:29:20 volumio volumio[930]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Nov 01 17:29:20 volumio volumio[930]: info: Unpacking python3-gi (3.30.4-1) ... Nov 01 17:29:20 volumio volumio[930]: info: Selecting previously unselected package python3-gi. Nov 01 17:29:20 volumio volumio[930]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Nov 01 17:29:20 volumio volumio[930]: info: Unpacking python3-gi (3.30.4-1) ... Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio sudo[3432]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 01 17:29:20 volumio sudo[3432]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:20 volumio sudo[3432]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:20 volumio volumio[930]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 01 17:29:20 volumio volumio[930]: info: camilladsp service started and running in background, instance 1 Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:29:20 volumio volumio[930]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 01 17:29:20 volumio volumio[930]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 01 17:29:20 volumio volumio[930]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 01 17:29:20 volumio volumio[930]: info: FusionDsp loaded Nov 01 17:29:20 volumio volumio[930]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:29:20 volumio sudo[3449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 01 17:29:20 volumio sudo[3449]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:29:20 volumio volumio[930]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 01 17:29:20 volumio volumio[930]: info: Adding Signal Path Element [object Object] Nov 01 17:29:20 volumio volumio[930]: info: Adding fusiondspeq DSP Signal Path Element Nov 01 17:29:20 volumio volumio[930]: info: FusionDsp - ---- installed callbackRead Nov 01 17:29:20 volumio volumio[930]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:29:20 volumio sudo[3449]: pam_unix(sudo:session): session closed for user root Nov 01 17:29:20 volumio volumio[930]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 01 17:29:20 volumio volumio[930]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 01 17:29:20 volumio volumio[930]: at onErrorNT (internal/child_process.js:465:16) Nov 01 17:29:20 volumio volumio[930]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 01 17:29:20 volumio volumio[930]: at runNextTicks (internal/process/task_queues.js:62:3) Nov 01 17:29:20 volumio volumio[930]: at listOnTimeout (internal/timers.js:523:9) Nov 01 17:29:20 volumio volumio[930]: at processTimers (internal/timers.js:497:7) { Nov 01 17:29:20 volumio volumio[930]: errno: -2, Nov 01 17:29:20 volumio volumio[930]: code: 'ENOENT', Nov 01 17:29:20 volumio volumio[930]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 01 17:29:20 volumio volumio[930]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 01 17:29:20 volumio volumio[930]: spawnargs: [ Nov 01 17:29:20 volumio volumio[930]: '-p', Nov 01 17:29:20 volumio volumio[930]: 9876, Nov 01 17:29:20 volumio volumio[930]: '-o', Nov 01 17:29:20 volumio volumio[930]: '/tmp/camilladsp.log', Nov 01 17:29:20 volumio volumio[930]: '-l', Nov 01 17:29:20 volumio volumio[930]: 'warn', Nov 01 17:29:20 volumio volumio[930]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 01 17:29:20 volumio volumio[930]: ] Nov 01 17:29:20 volumio volumio[930]: } Nov 01 17:29:20 volumio volumio[930]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:29:21 volumio sudo[3466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 17:28 Nov 01 17:29:21 volumio sudo[3466]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"