-- Logs begin at Tue 2024-06-04 20:59:47 CEST, end at Mon 2024-07-22 23:04:24 CEST. -- Jul 22 23:03:00 volumio volumio[4227]: info: Selecting previously unselected package binutils-common:armhf. Jul 22 23:03:00 volumio volumio[4227]: info: Preparing to unpack .../01-binutils-common_2.31.1-16_armhf.deb ... Jul 22 23:03:00 volumio volumio[4227]: info: Unpacking binutils-common:armhf (2.31.1-16) ... Jul 22 23:03:00 volumio volumio[4227]: info: Selecting previously unselected package libbinutils:armhf. Jul 22 23:03:00 volumio volumio[4227]: info: Preparing to unpack .../02-libbinutils_2.31.1-16_armhf.deb ... Jul 22 23:03:00 volumio volumio[4227]: info: Unpacking libbinutils:armhf (2.31.1-16) ... Jul 22 23:03:00 volumio volumio[4227]: info: Selecting previously unselected package binutils-arm-linux-gnueabihf. Jul 22 23:03:00 volumio volumio[4227]: info: Preparing to unpack .../03-binutils-arm-linux-gnueabihf_2.31.1-16_armhf.deb ... Jul 22 23:03:00 volumio volumio[4227]: info: Unpacking binutils-arm-linux-gnueabihf (2.31.1-16) ... Jul 22 23:03:01 volumio volumio[4227]: info: Selecting previously unselected package binutils. Jul 22 23:03:01 volumio volumio[4227]: info: Preparing to unpack .../04-binutils_2.31.1-16_armhf.deb ... Jul 22 23:03:01 volumio volumio[4227]: info: Unpacking binutils (2.31.1-16) ... Jul 22 23:03:01 volumio volumio[4227]: info: Selecting previously unselected package libcc1-0:armhf. Jul 22 23:03:01 volumio volumio[4227]: info: Preparing to unpack .../05-libcc1-0_8.3.0-6_armhf.deb ... Jul 22 23:03:01 volumio volumio[4227]: info: Unpacking libcc1-0:armhf (8.3.0-6) ... Jul 22 23:03:01 volumio volumio[4227]: info: Selecting previously unselected package libasan5:armhf. Jul 22 23:03:01 volumio volumio[4227]: info: Preparing to unpack .../06-libasan5_8.3.0-6_armhf.deb ... Jul 22 23:03:01 volumio volumio[4227]: info: Unpacking libasan5:armhf (8.3.0-6) ... Jul 22 23:03:01 volumio volumio[4227]: info: Selecting previously unselected package libubsan1:armhf. Jul 22 23:03:01 volumio volumio[4227]: info: Preparing to unpack .../07-libubsan1_8.3.0-6_armhf.deb ... Jul 22 23:03:01 volumio volumio[4227]: info: Unpacking libubsan1:armhf (8.3.0-6) ... Jul 22 23:03:01 volumio volumio[4227]: info: Selecting previously unselected package libgcc-8-dev:armhf. Jul 22 23:03:01 volumio volumio[4227]: info: Preparing to unpack .../08-libgcc-8-dev_8.3.0-6_armhf.deb ... Jul 22 23:03:01 volumio volumio[4227]: info: Unpacking libgcc-8-dev:armhf (8.3.0-6) ... Jul 22 23:03:02 volumio volumio[4227]: info: Selecting previously unselected package gcc-8. Jul 22 23:03:02 volumio volumio[4227]: info: Preparing to unpack .../09-gcc-8_8.3.0-6_armhf.deb ... Jul 22 23:03:02 volumio volumio[4227]: info: Unpacking gcc-8 (8.3.0-6) ... Jul 22 23:03:03 volumio volumio[4227]: info: Selecting previously unselected package gcc. Jul 22 23:03:03 volumio volumio[4227]: info: Preparing to unpack .../10-gcc_4%3a8.3.0-1_armhf.deb ... Jul 22 23:03:03 volumio volumio[4227]: info: Unpacking gcc (4:8.3.0-1) ... Jul 22 23:03:03 volumio volumio[4227]: info: Selecting previously unselected package libstdc++-8-dev:armhf. Jul 22 23:03:03 volumio volumio[4227]: info: Preparing to unpack .../11-libstdc++-8-dev_8.3.0-6_armhf.deb ... Jul 22 23:03:03 volumio volumio[4227]: info: Unpacking libstdc++-8-dev:armhf (8.3.0-6) ... Jul 22 23:03:04 volumio volumio[4227]: info: Selecting previously unselected package g++-8. Jul 22 23:03:04 volumio volumio[4227]: info: Preparing to unpack .../12-g++-8_8.3.0-6_armhf.deb ... Jul 22 23:03:04 volumio volumio[4227]: info: Unpacking g++-8 (8.3.0-6) ... Jul 22 23:03:05 volumio volumio[4227]: info: Selecting previously unselected package g++. Jul 22 23:03:05 volumio volumio[4227]: info: Preparing to unpack .../13-g++_4%3a8.3.0-1_armhf.deb ... Jul 22 23:03:05 volumio volumio[4227]: info: Unpacking g++ (4:8.3.0-1) ... Jul 22 23:03:05 volumio volumio[4227]: info: Selecting previously unselected package make. Jul 22 23:03:05 volumio volumio[4227]: info: Preparing to unpack .../14-make_4.2.1-1.2_armhf.deb ... Jul 22 23:03:05 volumio volumio[4227]: info: Unpacking make (4.2.1-1.2) ... Jul 22 23:03:05 volumio volumio[4227]: info: Selecting previously unselected package patch. Jul 22 23:03:05 volumio volumio[4227]: info: Preparing to unpack .../15-patch_2.7.6-3+deb10u1_armhf.deb ... Jul 22 23:03:06 volumio volumio[4227]: info: Unpacking patch (2.7.6-3+deb10u1) ... Jul 22 23:03:06 volumio volumio[4227]: info: Selecting previously unselected package dpkg-dev. Jul 22 23:03:06 volumio volumio[4227]: info: Preparing to unpack .../16-dpkg-dev_1.19.8_all.deb ... Jul 22 23:03:06 volumio volumio[4227]: info: Unpacking dpkg-dev (1.19.8) ... Jul 22 23:03:06 volumio volumio[4227]: info: Selecting previously unselected package build-essential. Jul 22 23:03:06 volumio volumio[4227]: info: Preparing to unpack .../17-build-essential_12.6_armhf.deb ... Jul 22 23:03:06 volumio volumio[4227]: info: Unpacking build-essential (12.6) ... Jul 22 23:03:06 volumio volumio[4227]: info: Selecting previously unselected package dh-python. Jul 22 23:03:06 volumio volumio[4227]: info: Preparing to unpack .../18-dh-python_3.20190308_all.deb ... Jul 22 23:03:06 volumio volumio[4227]: info: Unpacking dh-python (3.20190308) ... Jul 22 23:03:06 volumio volumio[4227]: info: Selecting previously unselected package libfakeroot:armhf. Jul 22 23:03:06 volumio volumio[4227]: info: Preparing to unpack .../19-libfakeroot_1.23-1_armhf.deb ... Jul 22 23:03:06 volumio volumio[4227]: info: Unpacking libfakeroot:armhf (1.23-1) ... Jul 22 23:03:06 volumio volumio[4227]: info: Selecting previously unselected package fakeroot. Jul 22 23:03:06 volumio volumio[4227]: info: Preparing to unpack .../20-fakeroot_1.23-1_armhf.deb ... Jul 22 23:03:06 volumio volumio[4227]: info: Unpacking fakeroot (1.23-1) ... Jul 22 23:03:07 volumio volumio[4227]: info: Selecting previously unselected package libalgorithm-diff-perl. Jul 22 23:03:07 volumio volumio[4227]: info: Preparing to unpack .../21-libalgorithm-diff-perl_1.19.03-2_all.deb ... Jul 22 23:03:07 volumio volumio[4227]: info: Unpacking libalgorithm-diff-perl (1.19.03-2) ... Jul 22 23:03:07 volumio volumio[4227]: info: Selecting previously unselected package libalgorithm-diff-xs-perl. Jul 22 23:03:07 volumio volumio[4227]: info: Preparing to unpack .../22-libalgorithm-diff-xs-perl_0.04-5+b1_armhf.deb ... Jul 22 23:03:07 volumio volumio[4227]: info: Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ... Jul 22 23:03:07 volumio volumio[4227]: info: Selecting previously unselected package libalgorithm-merge-perl. Jul 22 23:03:07 volumio volumio[4227]: info: Preparing to unpack .../23-libalgorithm-merge-perl_0.08-3_all.deb ... Jul 22 23:03:07 volumio volumio[4227]: info: Unpacking libalgorithm-merge-perl (0.08-3) ... Jul 22 23:03:07 volumio volumio[4227]: info: Selecting previously unselected package libexpat1-dev:armhf. Jul 22 23:03:07 volumio volumio[4227]: info: Preparing to unpack .../24-libexpat1-dev_2.2.6-2+deb10u4_armhf.deb ... Jul 22 23:03:07 volumio volumio[4227]: info: Unpacking libexpat1-dev:armhf (2.2.6-2+deb10u4) ... Jul 22 23:03:07 volumio volumio[4227]: info: Selecting previously unselected package libpython3.7:armhf. Jul 22 23:03:07 volumio volumio[4227]: info: Preparing to unpack .../25-libpython3.7_3.7.3-2+deb10u3_armhf.deb ... Jul 22 23:03:07 volumio volumio[4227]: info: Unpacking libpython3.7:armhf (3.7.3-2+deb10u3) ... Jul 22 23:03:08 volumio volumio[4227]: info: Selecting previously unselected package libpython3.7-dev:armhf. Jul 22 23:03:08 volumio volumio[4227]: info: Preparing to unpack .../26-libpython3.7-dev_3.7.3-2+deb10u3_armhf.deb ... Jul 22 23:03:08 volumio volumio[4227]: info: Unpacking libpython3.7-dev:armhf (3.7.3-2+deb10u3) ... Jul 22 23:03:13 volumio volumio[4227]: info: Selecting previously unselected package libpython3-dev:armhf. Jul 22 23:03:13 volumio volumio[4227]: info: Preparing to unpack .../27-libpython3-dev_3.7.3-1_armhf.deb ... Jul 22 23:03:13 volumio volumio[4227]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ... Jul 22 23:03:13 volumio volumio[4227]: info: Selecting previously unselected package python-pip-whl. Jul 22 23:03:13 volumio volumio[4227]: info: Preparing to unpack .../28-python-pip-whl_18.1-5_all.deb ... Jul 22 23:03:13 volumio volumio[4227]: info: Unpacking python-pip-whl (18.1-5) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-multidict. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../29-python3-multidict_4.5.2-1_armhf.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-multidict (4.5.2-1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-yarl. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../30-python3-yarl_1.3.0-1_armhf.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-yarl (1.3.0-1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-async-timeout. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../31-python3-async-timeout_3.0.1-1_all.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-async-timeout (3.0.1-1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-attr. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../32-python3-attr_18.2.0-1_all.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-attr (18.2.0-1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-aiohttp. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../33-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-asn1crypto. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../34-python3-asn1crypto_0.24.0-1_all.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-cffi-backend. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../35-python3-cffi-backend_1.12.2-1_armhf.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Jul 22 23:03:14 volumio volumio[4227]: info: Selecting previously unselected package python3-crypto. Jul 22 23:03:14 volumio volumio[4227]: info: Preparing to unpack .../36-python3-crypto_2.6.1-9+b1_armhf.deb ... Jul 22 23:03:14 volumio volumio[4227]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-cryptography. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../37-python3-cryptography_2.6.1-3+deb10u2_armhf.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-cryptography (2.6.1-3+deb10u2) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-dbus. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../38-python3-dbus_1.2.8-3_armhf.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-dbus (1.2.8-3) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3.7-dev. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../39-python3.7-dev_3.7.3-2+deb10u3_armhf.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3.7-dev (3.7.3-2+deb10u3) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-dev. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../40-python3-dev_3.7.3-1_armhf.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-dev (3.7.3-1) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-entrypoints. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../41-python3-entrypoints_0.3-1_all.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-entrypoints (0.3-1) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-gi. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../42-python3-gi_3.30.4-1_armhf.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-gi (3.30.4-1) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-secretstorage. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../43-python3-secretstorage_2.3.1-2_all.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-secretstorage (2.3.1-2) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-keyring. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../44-python3-keyring_17.1.1-1_all.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-keyring (17.1.1-1) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-keyrings.alt. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../45-python3-keyrings.alt_3.1.1-1_all.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Jul 22 23:03:15 volumio volumio[4227]: info: Selecting previously unselected package python3-pip. Jul 22 23:03:15 volumio volumio[4227]: info: Preparing to unpack .../46-python3-pip_18.1-5_all.deb ... Jul 22 23:03:15 volumio volumio[4227]: info: Unpacking python3-pip (18.1-5) ... Jul 22 23:03:16 volumio volumio[4227]: info: Selecting previously unselected package python3-setuptools. Jul 22 23:03:16 volumio volumio[4227]: info: Preparing to unpack .../47-python3-setuptools_40.8.0-1_all.deb ... Jul 22 23:03:16 volumio volumio[4227]: info: Unpacking python3-setuptools (40.8.0-1) ... Jul 22 23:03:16 volumio volumio[4227]: info: Selecting previously unselected package python3-wheel. Jul 22 23:03:16 volumio volumio[4227]: info: Preparing to unpack .../48-python3-wheel_0.32.3-2_all.deb ... Jul 22 23:03:16 volumio volumio[4227]: info: Unpacking python3-wheel (0.32.3-2) ... Jul 22 23:03:16 volumio volumio[4227]: info: Selecting previously unselected package python3-xdg. Jul 22 23:03:16 volumio volumio[4227]: info: Preparing to unpack .../49-python3-xdg_0.25-5_all.deb ... Jul 22 23:03:16 volumio volumio[4227]: info: Unpacking python3-xdg (0.25-5) ... Jul 22 23:03:16 volumio volumio[4227]: info: Setting up python3-entrypoints (0.3-1) ... Jul 22 23:03:16 volumio volumio[4227]: info: Setting up dh-python (3.20190308) ... Jul 22 23:03:17 volumio volumio[4227]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.13 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 22 23:03:17 volumio volumio[4227]: info: CoreCommandRouter::volumioGetVisibleSources Jul 22 23:03:17 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 23:03:17 volumio volumio[4227]: info: CoreCommandRouter::volumioGetState Jul 22 23:03:17 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:03:17 volumio volumio[4227]: info: CoreCommandRouter::volumioGetQueue Jul 22 23:03:17 volumio volumio[4227]: info: CoreStateMachine::getQueue Jul 22 23:03:17 volumio volumio[4227]: info: CorePlayQueue::getQueue Jul 22 23:03:17 volumio volumio[4227]: info: Listing playlists Jul 22 23:03:17 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 22 23:03:17 volumio volumio[4227]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 22 23:03:17 volumio volumio[4227]: info: Setting up python3-attr (18.2.0-1) ... Jul 22 23:03:17 volumio volumio[4227]: info: Setting up python3-dbus (1.2.8-3) ... Jul 22 23:03:18 volumio volumio[4227]: info: Setting up python3-setuptools (40.8.0-1) ... Jul 22 23:03:18 volumio volumio[4227]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u3) ... Jul 22 23:03:18 volumio volumio[4227]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Jul 22 23:03:18 volumio volumio[4227]: info: Setting up binutils-common:armhf (2.31.1-16) ... Jul 22 23:03:18 volumio volumio[4227]: info: Setting up python3-xdg (0.25-5) ... Jul 22 23:03:19 volumio volumio[4227]: info: Setting up bzip2 (1.0.6-9.2~deb10u1) ... Jul 22 23:03:19 volumio volumio[4227]: info: Setting up python3-wheel (0.32.3-2) ... Jul 22 23:03:19 volumio volumio[4227]: info: Setting up python3-multidict (4.5.2-1) ... Jul 22 23:03:20 volumio volumio[4227]: info: Setting up libfakeroot:armhf (1.23-1) ... Jul 22 23:03:20 volumio volumio[4227]: info: Setting up python3-async-timeout (3.0.1-1) ... Jul 22 23:03:20 volumio volumio[4227]: info: Setting up fakeroot (1.23-1) ... Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/fakeroot.1.gz because associated file /usr/share/man/es/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/faked.1.gz because associated file /usr/share/man/es/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/fakeroot.1.gz because associated file /usr/share/man/fr/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/faked.1.gz because associated file /usr/share/man/fr/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/fakeroot.1.gz because associated file /usr/share/man/sv/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Jul 22 23:03:20 volumio volumio[4227]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/faked.1.gz because associated file /usr/share/man/sv/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Jul 22 23:03:20 volumio volumio[4227]: info: Setting up libasan5:armhf (8.3.0-6) ... Jul 22 23:03:20 volumio volumio[4227]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u4) ... Jul 22 23:03:20 volumio volumio[4227]: info: Setting up make (4.2.1-1.2) ... Jul 22 23:03:20 volumio volumio[4227]: info: Setting up python3-gi (3.30.4-1) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up patch (2.7.6-3+deb10u1) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up libubsan1:armhf (8.3.0-6) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up python3-crypto (2.6.1-9+b1) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up python-pip-whl (18.1-5) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up libbinutils:armhf (2.31.1-16) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up binutils-arm-linux-gnueabihf (2.31.1-16) ... Jul 22 23:03:21 volumio volumio[4227]: info: Setting up python3-yarl (1.3.0-1) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up python3-asn1crypto (0.24.0-1) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up libcc1-0:armhf (8.3.0-6) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up python3-cffi-backend (1.12.2-1) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u3) ... Jul 22 23:03:22 volumio volumio[4227]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Jul 22 23:03:23 volumio volumio[4227]: info: Setting up binutils (2.31.1-16) ... Jul 22 23:03:23 volumio volumio[4227]: info: Setting up python3.7-dev (3.7.3-2+deb10u3) ... Jul 22 23:03:23 volumio volumio[4227]: info: Setting up dpkg-dev (1.19.8) ... Jul 22 23:03:23 volumio volumio[4227]: info: Setting up python3-cryptography (2.6.1-3+deb10u2) ... Jul 22 23:03:24 volumio volumio[4227]: info: Setting up python3-pip (18.1-5) ... Jul 22 23:03:24 volumio volumio[4227]: info: Setting up libgcc-8-dev:armhf (8.3.0-6) ... Jul 22 23:03:24 volumio volumio[4227]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up gcc-8 (8.3.0-6) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up gcc (4:8.3.0-1) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up python3-secretstorage (2.3.1-2) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up python3-dev (3.7.3-1) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up g++-8 (8.3.0-6) ... Jul 22 23:03:25 volumio volumio[4227]: info: Setting up python3-keyring (17.1.1-1) ... Jul 22 23:03:26 volumio volumio[4227]: info: Setting up g++ (4:8.3.0-1) ... Jul 22 23:03:26 volumio volumio[4227]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Jul 22 23:03:26 volumio volumio[4227]: info: Setting up build-essential (12.6) ... Jul 22 23:03:26 volumio volumio[4227]: info: Processing triggers for man-db (2.8.5-2) ... Jul 22 23:03:26 volumio volumio[4227]: info: Processing triggers for libc-bin (2.28-10+deb10u1) ... Jul 22 23:03:27 volumio volumio[4227]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jul 22 23:03:27 volumio sudo[13615]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:27 volumio sudo[14743]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Jul 22 23:03:27 volumio sudo[14743]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:27 volumio volumio[4227]: info: lib/systemd/system/fusiondsp.service Jul 22 23:03:27 volumio sudo[14743]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:29 volumio volumio[4227]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jul 22 23:03:29 volumio volumio[4227]: info: Folder /tmp/plugins removed Jul 22 23:03:29 volumio volumio[4227]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Jul 22 23:03:29 volumio volumio[4227]: info: more info at http://www.winimage.com/zLibDll/unzip.html Jul 22 23:03:29 volumio volumio[4227]: info: Jul 22 23:03:29 volumio volumio[4227]: info: cgui-1.0.0.zip opened Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/LICENSE.txt Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/README.md Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/build/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/robots.txt Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/logo512.png Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/asset-manifest.json Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/index.html Jul 22 23:03:29 volumio sudo[14756]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/.put_statics_here Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/favicon.ico Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/logo192.png Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/manifest.json Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/css-variables.css Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/service-worker.js Jul 22 23:03:29 volumio sudo[14756]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/build/static/ Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/build/static/css/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Jul 22 23:03:29 volumio sudo[14756]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/main.1503f6cd.css Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/build/static/media/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/build/static/js/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.71e11955.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Jul 22 23:03:29 volumio sudo[14765]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.71e11955.js.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/config/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/config/camillagui.yml Jul 22 23:03:29 volumio sudo[14765]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/config/gui-config.yml Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/backend/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/filters_test.py Jul 22 23:03:29 volumio sudo[14765]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/version.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/filters.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/settings.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/views.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/filterdefaults.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__init__.py Jul 22 23:03:29 volumio volumio[4227]: info: creating directory: cgui/backend/__pycache__/ Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/routes.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/backend/filemanagement.py Jul 22 23:03:29 volumio volumio[4227]: info: extracting: cgui/main.py Jul 22 23:03:29 volumio sudo[14774]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Jul 22 23:03:29 volumio sudo[14774]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:29 volumio sudo[14774]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:29 volumio volumio[4227]: info: Check plugin dependencies Jul 22 23:03:29 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 22 23:03:29 volumio volumio[4227]: info: Checking if plugin already exists Jul 22 23:03:29 volumio volumio[4227]: info: Rename folder Jul 22 23:03:29 volumio volumio[4227]: info: Folder /tmp/downloaded_plugin.zip removed Jul 22 23:03:29 volumio volumio[4227]: info: Move to category Jul 22 23:03:30 volumio volumio[4227]: info: Checking if install.sh is present Jul 22 23:03:30 volumio volumio[4227]: info: Executing install.sh Jul 22 23:03:30 volumio sudo[14794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Jul 22 23:03:30 volumio sudo[14794]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:30 volumio volumio[4227]: info: creating filters folder and copying demo filters Jul 22 23:03:30 volumio volumio[4227]: info: creating filters folder and copying demo filters Jul 22 23:03:30 volumio volumio[4227]: info: copying demo flters Jul 22 23:03:30 volumio volumio[4227]: info: copying demo flters Jul 22 23:03:30 volumio sudo[14820]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Jul 22 23:03:30 volumio volumio[4227]: info: Installing/fusiondsp dependencies Jul 22 23:03:30 volumio volumio[4227]: info: Installing/fusiondsp dependencies Jul 22 23:03:30 volumio sudo[14820]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:31 volumio volumio[4227]: info: Hit:1 http://deb.debian.org/debian buster InRelease Jul 22 23:03:31 volumio volumio[4227]: info: Hit:1 http://deb.debian.org/debian buster InRelease Jul 22 23:03:31 volumio volumio[4227]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Jul 22 23:03:31 volumio volumio[4227]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Jul 22 23:03:34 volumio volumio[4227]: info: Reading package lists... Jul 22 23:03:34 volumio volumio[4227]: info: Reading package lists... Jul 22 23:03:35 volumio volumio[4227]: info: Building dependency tree... Jul 22 23:03:35 volumio volumio[4227]: info: Building dependency tree... Jul 22 23:03:35 volumio volumio[4227]: info: Reading state information... Jul 22 23:03:35 volumio volumio[4227]: info: Reading state information... Jul 22 23:03:35 volumio volumio[4227]: info: All packages are up to date. Jul 22 23:03:35 volumio volumio[4227]: info: All packages are up to date. Jul 22 23:03:35 volumio sudo[14820]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:35 volumio sudo[15054]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Jul 22 23:03:35 volumio sudo[15054]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:35 volumio volumio[4227]: info: Reading package lists... Jul 22 23:03:35 volumio volumio[4227]: info: Reading package lists... Jul 22 23:03:35 volumio volumio[4227]: info: Building dependency tree... Jul 22 23:03:35 volumio volumio[4227]: copying hw detection script Jul 22 23:03:35 volumio volumio[4227]: info: Building dependency tree... Jul 22 23:03:35 volumio volumio[4227]: copying hw detection script Jul 22 23:03:35 volumio volumio[4227]: info: Detected cpu architecture as armv7l Jul 22 23:03:36 volumio volumio[4227]: info: camilladsp Jul 22 23:03:36 volumio volumio[4227]: info: camilladsp Jul 22 23:03:36 volumio sudo[15073]: 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 Jul 22 23:03:36 volumio sudo[15073]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:36 volumio sudo[15073]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:37 volumio sudo[15082]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Jul 22 23:03:37 volumio sudo[15082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:37 volumio sudo[15054]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:37 volumio sudo[15082]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:37 volumio sudo[15095]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Jul 22 23:03:37 volumio sudo[15096]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Jul 22 23:03:37 volumio sudo[15095]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:37 volumio sudo[15096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:37 volumio sudo[15095]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:37 volumio volumio[4227]: info: Reading package lists... Jul 22 23:03:37 volumio volumio[4227]: info: Reading package lists... Jul 22 23:03:37 volumio volumio[4227]: info: Building dependency tree... Jul 22 23:03:37 volumio volumio[4227]: info: Building dependency tree... Jul 22 23:03:37 volumio volumio[4227]: info: Reading state information... Jul 22 23:03:37 volumio volumio[4227]: info: Reading state information... Jul 22 23:03:38 volumio sudo[15114]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Jul 22 23:03:38 volumio sudo[15114]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:38 volumio sudo[15114]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:38 volumio sudo[15123]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Jul 22 23:03:38 volumio sudo[15123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:38 volumio sudo[15123]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:38 volumio sudo[15132]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Jul 22 23:03:38 volumio sudo[15132]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:38 volumio sudo[15132]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:38 volumio volumio[4227]: info: The following NEW packages will be installed: Jul 22 23:03:38 volumio volumio[4227]: info: The following NEW packages will be installed: Jul 22 23:03:38 volumio volumio[4227]: info: drc Jul 22 23:03:38 volumio volumio[4227]: info: drc Jul 22 23:03:39 volumio volumio[4227]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Jul 22 23:03:39 volumio volumio[4227]: info: Need to get 118 kB of archives. Jul 22 23:03:39 volumio volumio[4227]: info: After this operation, 471 kB of additional disk space will be used. Jul 22 23:03:39 volumio volumio[4227]: info: Get:1 http://deb.debian.org/debian buster/main armhf drc armhf 3.2.2~dfsg0-2 [118 kB] Jul 22 23:03:39 volumio volumio[4227]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Jul 22 23:03:39 volumio volumio[4227]: info: Need to get 118 kB of archives. Jul 22 23:03:39 volumio volumio[4227]: info: After this operation, 471 kB of additional disk space will be used. Jul 22 23:03:39 volumio volumio[4227]: info: Get:1 http://deb.debian.org/debian buster/main armhf drc armhf 3.2.2~dfsg0-2 [118 kB] Jul 22 23:03:39 volumio volumio[4227]: info: Fetched 118 kB in 0s (325 kB/s) Jul 22 23:03:39 volumio volumio[4227]: info: Fetched 118 kB in 0s (325 kB/s) Jul 22 23:03:40 volumio volumio[4227]: info: Selecting previously unselected package drc. Jul 22 23:03:40 volumio volumio[4227]: info: Selecting previously unselected package drc. Jul 22 23:03:40 volumio volumio[4227]: [620B blob data] Jul 22 23:03:40 volumio volumio[4227]: [620B blob data] Jul 22 23:03:40 volumio volumio[4227]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Jul 22 23:03:40 volumio volumio[4227]: info: Unpacking drc (3.2.2~dfsg0-2) ... Jul 22 23:03:40 volumio volumio[4227]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Jul 22 23:03:40 volumio volumio[4227]: info: Unpacking drc (3.2.2~dfsg0-2) ... Jul 22 23:03:40 volumio volumio[4227]: info: Setting up drc (3.2.2~dfsg0-2) ... Jul 22 23:03:40 volumio volumio[4227]: info: Setting up drc (3.2.2~dfsg0-2) ... Jul 22 23:03:40 volumio volumio[4227]: info: Processing triggers for man-db (2.8.5-2) ... Jul 22 23:03:40 volumio volumio[4227]: info: Processing triggers for man-db (2.8.5-2) ... Jul 22 23:03:41 volumio sudo[15096]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:41 volumio sudo[13353]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:41 volumio volumio[4227]: Plugin install end detected on script Jul 22 23:03:41 volumio volumio[4227]: info: Install script completed Jul 22 23:03:41 volumio volumio[4227]: info: Adding reference to registry Jul 22 23:03:41 volumio volumio[4227]: info: Done installing plugin. Jul 22 23:03:41 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 22 23:03:41 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 22 23:03:41 volumio volumio[4227]: info: Folder /tmp/plugins removed Jul 22 23:03:41 volumio volumio[4227]: info: Folder /tmp/downloaded_plugin.zip removed Jul 22 23:03:41 volumio volumio[4227]: info: Folder /data/temp removed Jul 22 23:03:55 volumio volumio[4227]: info: Enabling plugin fusiondsp Jul 22 23:03:55 volumio volumio[4227]: info: Loading plugin "fusiondsp"... Jul 22 23:03:55 volumio volumio[4227]: info: Preparing to generate the ALSA configuration file Jul 22 23:03:55 volumio volumio[4227]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 23:03:55 volumio volumio[4227]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 22 23:03:55 volumio volumio[4227]: info: Reading ALSA contributions from plugins. Jul 22 23:03:55 volumio volumio[4227]: info: Asound.conf file written Jul 22 23:03:55 volumio sudo[15230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 22 23:03:55 volumio sudo[15230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:55 volumio sudo[15230]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:55 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:55 volumio volumio[4227]: No state is present for card DAC Jul 22 23:03:55 volumio volumio[4227]: Found hardware: "ES90x8Q2M_DAC" "" "" "" "" Jul 22 23:03:55 volumio volumio[4227]: Hardware is initialized using a generic method Jul 22 23:03:55 volumio volumio[4227]: No state is present for card DAC Jul 22 23:03:55 volumio volumio[4227]: No state is present for card OnBoard Jul 22 23:03:55 volumio volumio[4227]: Found hardware: "USB-Audio" "USB Mixer" "USB0bda:481a" "" "" Jul 22 23:03:55 volumio volumio[4227]: Hardware is initialized using a generic method Jul 22 23:03:55 volumio volumio[4227]: No state is present for card OnBoard Jul 22 23:03:55 volumio volumio[4227]: info: Output device has changed, restarting MPD Jul 22 23:03:55 volumio sudo[15242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 23:03:55 volumio volumio[4227]: info: Output device has changed, restarting Shairport Sync Jul 22 23:03:55 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:55 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:55 volumio sudo[15242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:55 volumio sudo[15242]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:55 volumio sudo[15247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 23:03:55 volumio sudo[15247]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:55 volumio systemd[1]: Stopping Music Player Daemon... Jul 22 23:03:55 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:55 volumio volumio[4227]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 23:03:55 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:55 volumio vtcs[6981]: [2024-07-22 23:03:55.939] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jul 22 23:03:55 volumio vtcs[6981]: [2024-07-22 23:03:55.940] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Jul 22 23:03:55 volumio vtcs[6981]: [2024-07-22 23:03:55.940] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jul 22 23:03:55 volumio systemd[1]: mpd.service: Succeeded. Jul 22 23:03:55 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 23:03:55 volumio systemd[1]: Starting Music Player Daemon... Jul 22 23:03:55 volumio volumio[4227]: info: PLUGIN START: fusiondsp Jul 22 23:03:55 volumio sudo[15265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:56 volumio sudo[15265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio sudo[15264]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 23:03:56 volumio sudo[15264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jul 22 23:03:56 volumio volumio[4227]: info: Loading i18n strings for locale fr Jul 22 23:03:56 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 22 23:03:56 volumio systemd[1]: vtcs.service: Succeeded. Jul 22 23:03:56 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: FusionDsp - mixtype--------------------- Hardware Jul 22 23:03:56 volumio volumio[4227]: info: Preparing to generate the ALSA configuration file Jul 22 23:03:56 volumio sudo[15265]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio sudo[15264]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio volumio[4227]: info: Done. Jul 22 23:03:56 volumio volumio[4227]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 23:03:56 volumio volumio[4227]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 22 23:03:56 volumio volumio[4227]: info: Reading ALSA contributions from plugins. Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:56 volumio sudo[15285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:56 volumio sudo[15285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio volumio[4227]: info: MPD Permissions set Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio sudo[15285]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: Starting Shairport Sync Jul 22 23:03:56 volumio volumio[4227]: info: Asound.conf file unchanged, so no further update is needed Jul 22 23:03:56 volumio volumio[4227]: info: Output device has changed, restarting MPD Jul 22 23:03:56 volumio sudo[15303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 23:03:56 volumio sudo[15303]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio sudo[15309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 23:03:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 23:03:56 volumio sudo[15309]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio volumio[4227]: info: Output device has changed, restarting Shairport Sync Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:56 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 23:03:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:56 volumio sudo[15309]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:56 volumio sudo[15303]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio sudo[15316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 23:03:56 volumio sudo[15316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:56 volumio volumio[4227]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: Preparing to generate the ALSA configuration file Jul 22 23:03:56 volumio sudo[15340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:56 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 22 23:03:56 volumio systemd[1]: mpd.service: Succeeded. Jul 22 23:03:56 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 23:03:56 volumio sudo[15340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio systemd[1]: Starting Music Player Daemon... Jul 22 23:03:56 volumio volumio[4227]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 23:03:56 volumio volumio[4227]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 22 23:03:56 volumio volumio[4227]: info: Reading ALSA contributions from plugins. Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:56 volumio sudo[15347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:56 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:56 volumio volumio[4227]: info: MPD Permissions set Jul 22 23:03:56 volumio sudo[15347]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio volumio[4227]: info: Shairport-Sync Started Jul 22 23:03:56 volumio sudo[15340]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio sudo[15347]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 22 23:03:56 volumio sudo[15346]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 23:03:56 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:56 volumio sudo[15346]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio volumio[4227]: info: Starting Shairport Sync Jul 22 23:03:56 volumio sudo[15346]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio volumio[4227]: info: Enabling plugin fusiondsp Jul 22 23:03:56 volumio volumio[4227]: info: Loading plugin "fusiondsp"... Jul 22 23:03:56 volumio volumio[4227]: info: Applying required configuration parameters for plugin fusiondsp Jul 22 23:03:56 volumio sudo[15377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 23:03:56 volumio volumio[4227]: info: Asound.conf file written Jul 22 23:03:56 volumio sudo[15377]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio sudo[15383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 22 23:03:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 23:03:56 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 23:03:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:56 volumio sudo[15383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:56 volumio sudo[15377]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:56 volumio sudo[15383]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:57 volumio volumio[4227]: No state is present for card DAC Jul 22 23:03:57 volumio volumio[4227]: Found hardware: "ES90x8Q2M_DAC" "" "" "" "" Jul 22 23:03:57 volumio volumio[4227]: Hardware is initialized using a generic method Jul 22 23:03:57 volumio volumio[4227]: No state is present for card DAC Jul 22 23:03:57 volumio volumio[4227]: No state is present for card OnBoard Jul 22 23:03:57 volumio volumio[4227]: Found hardware: "USB-Audio" "USB Mixer" "USB0bda:481a" "" "" Jul 22 23:03:57 volumio volumio[4227]: Hardware is initialized using a generic method Jul 22 23:03:57 volumio volumio[4227]: No state is present for card OnBoard Jul 22 23:03:57 volumio volumio[4227]: info: Output device has changed, restarting MPD Jul 22 23:03:57 volumio sudo[15403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 23:03:57 volumio volumio[4227]: info: Output device has changed, restarting Shairport Sync Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:57 volumio sudo[15403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio sudo[15403]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio sudo[15410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 23:03:57 volumio sudo[15410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:57 volumio volumio[4227]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 22 23:03:57 volumio systemd[1]: mpd.service: Succeeded. Jul 22 23:03:57 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 23:03:57 volumio systemd[1]: Starting Music Player Daemon... Jul 22 23:03:57 volumio sudo[15425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:57 volumio sudo[15425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio volumio[4227]: info: Preparing to generate the ALSA configuration file Jul 22 23:03:57 volumio sudo[15425]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio sudo[15426]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 23:03:57 volumio volumio[4227]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 23:03:57 volumio volumio[4227]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 22 23:03:57 volumio volumio[4227]: info: Reading ALSA contributions from plugins. Jul 22 23:03:57 volumio sudo[15440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:57 volumio sudo[15426]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:57 volumio sudo[15426]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio sudo[15440]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:57 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:57 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:57 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:57 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:57 volumio sudo[15440]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio volumio[4227]: info: MPD Permissions set Jul 22 23:03:57 volumio volumio[4227]: info: Shairport-Sync Started Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: Starting Shairport Sync Jul 22 23:03:57 volumio volumio[4227]: info: Asound.conf file unchanged, so no further update is needed Jul 22 23:03:57 volumio volumio[4227]: info: Output device has changed, restarting MPD Jul 22 23:03:57 volumio sudo[15464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 23:03:57 volumio sudo[15464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio volumio[4227]: info: Output device has changed, restarting Shairport Sync Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 23:03:57 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 23:03:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:57 volumio sudo[15469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 23:03:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:57 volumio sudo[15464]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:57 volumio volumio[4227]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio sudo[15469]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio sudo[15474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 23:03:57 volumio sudo[15469]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:57 volumio sudo[15474]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio volumio[4227]: info: PLUGIN START: fusiondsp Jul 22 23:03:57 volumio volumio[4227]: info: Loading i18n strings for locale fr Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 22 23:03:57 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:57 volumio volumio[4227]: info: FusionDsp - mixtype--------------------- Hardware Jul 22 23:03:57 volumio volumio[4227]: info: Preparing to generate the ALSA configuration file Jul 22 23:03:57 volumio sudo[15500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:57 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 22 23:03:57 volumio systemd[1]: mpd.service: Succeeded. Jul 22 23:03:57 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 23:03:57 volumio systemd[1]: Starting Music Player Daemon... Jul 22 23:03:57 volumio volumio[4227]: info: Done. Jul 22 23:03:57 volumio sudo[15500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:57 volumio sudo[15500]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:58 volumio volumio[4227]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 23:03:58 volumio volumio[4227]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 22 23:03:58 volumio volumio[4227]: info: Reading ALSA contributions from plugins. Jul 22 23:03:58 volumio sudo[15508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:58 volumio sudo[15503]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 23:03:58 volumio sudo[15508]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:58 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:58 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:58 volumio sudo[15503]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:58 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:58 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:58 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:58 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:58 volumio sudo[15503]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:58 volumio sudo[15508]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:58 volumio volumio[4227]: info: MPD Permissions set Jul 22 23:03:58 volumio volumio[4227]: info: Shairport-Sync Started Jul 22 23:03:58 volumio volumio[4227]: info: camilladsp spawned new process with pid 15536, instance 1, run: true Jul 22 23:03:58 volumio volumio[4227]: info: camilladsp service started and running in background, instance 1 Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:58 volumio volumio[4227]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Jul 22 23:03:58 volumio volumio[4227]: info: FusionDsp loaded Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 22 23:03:58 volumio sudo[15544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 22 23:03:58 volumio volumio[4227]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 22 23:03:58 volumio sudo[15544]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:58 volumio volumio[4227]: info: Adding Signal Path Element [object Object] Jul 22 23:03:58 volumio volumio[4227]: info: Adding fusiondspeq DSP Signal Path Element Jul 22 23:03:58 volumio volumio[4227]: info: FusionDsp - ---- installed callbackRead Jul 22 23:03:58 volumio volumio[4227]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 22 23:03:58 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:03:58 volumio sudo[15544]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:58 volumio volumio[4227]: error: FusionDsp - WebSocket error: [object Object] Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 22 23:03:58 volumio volumio[4227]: info: Starting Shairport Sync Jul 22 23:03:58 volumio volumio[4227]: info: Asound.conf file unchanged, so no further update is needed Jul 22 23:03:58 volumio volumio[4227]: info: Output device has changed, restarting MPD Jul 22 23:03:58 volumio sudo[15561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 23:03:58 volumio sudo[15561]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:58 volumio volumio[4227]: info: Output device has changed, restarting Shairport Sync Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:58 volumio sudo[15568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 23:03:58 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 23:03:58 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 23:03:58 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:58 volumio sudo[15568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:58 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:58 volumio sudo[15572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 23:03:58 volumio sudo[15561]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:58 volumio sudo[15568]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:58 volumio sudo[15572]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:58 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:03:58 volumio volumio[4227]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 23:03:58 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio sudo[15594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:59 volumio sudo[15594]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:59 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 22 23:03:59 volumio systemd[1]: mpd.service: Succeeded. Jul 22 23:03:59 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 23:03:59 volumio systemd[1]: Starting Music Player Daemon... Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:59 volumio volumio[4227]: info: MPD Permissions set Jul 22 23:03:59 volumio volumio[4227]: info: Shairport-Sync Started Jul 22 23:03:59 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio sudo[15594]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio sudo[15605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 22 23:03:59 volumio sudo[15605]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:03:59 volumio volumio[4227]: info: Starting Shairport Sync Jul 22 23:03:59 volumio sudo[15604]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 23:03:59 volumio sudo[15605]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:59 volumio sudo[15604]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:59 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:03:59 volumio sudo[15604]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:59 volumio sudo[15632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 23:03:59 volumio sudo[15632]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:59 volumio volumio[4227]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:03:59 volumio volumio[4227]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:03:59 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 23:03:59 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 23:03:59 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:59 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 23:03:59 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:03:59 volumio sudo[15632]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:59 volumio volumio[4227]: info: Shairport-Sync Started Jul 22 23:03:59 volumio sudo[15652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 22 23:03:59 volumio volumio[4227]: (node:4227) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jul 22 23:03:59 volumio sudo[15652]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:59 volumio volumio[4227]: (node:4227) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jul 22 23:03:59 volumio volumio[4227]: (node:4227) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jul 22 23:03:59 volumio volumio[4227]: (node:4227) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jul 22 23:03:59 volumio volumio[4227]: (node:4227) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jul 22 23:03:59 volumio volumio[15550]: Traceback (most recent call last): Jul 22 23:03:59 volumio volumio[15550]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jul 22 23:03:59 volumio volumio[15550]: from camilladsp import CamillaConnection Jul 22 23:03:59 volumio volumio[15550]: ModuleNotFoundError: No module named 'camilladsp' Jul 22 23:03:59 volumio systemd[1]: Started Volumio Tidal Connect Service. Jul 22 23:03:59 volumio sudo[15652]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:59 volumio volumio[4227]: 0+0 records in Jul 22 23:03:59 volumio volumio[4227]: 0+0 records out Jul 22 23:03:59 volumio volumio[4227]: 0 bytes copied, 0.000348836 s, 0.0 kB/s Jul 22 23:03:59 volumio volumio[4227]: info: camilladsp spawned new process with pid 15670, instance 1, run: true Jul 22 23:03:59 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:03:59 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:03:59 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:03:59 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:03:59 volumio volumio[4227]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:03:59 volumio volumio[4227]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:03:59 volumio sudo[15688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 22 23:03:59 volumio sudo[15688]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:03:59 volumio sudo[15688]: pam_unix(sudo:session): session closed for user root Jul 22 23:03:59 volumio volumio[4227]: info: Executing endpoint tc_getconfig Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 22 23:03:59 volumio vtcs[15664]: STARTING TidalConnect services, version: 1.4.0.34 Jul 22 23:03:59 volumio volumio[4227]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 22 23:03:59 volumio volumio[4227]: 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 Jul 22 23:03:59 volumio volumio[4227]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 22 23:03:59 volumio volumio[4227]: info: camilladsp spawned new process with pid 15705, instance 2, run: true Jul 22 23:03:59 volumio volumio[4227]: info: camilladsp service started and running in background, instance 2 Jul 22 23:03:59 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 23:04:00 volumio vtcs[15664]: STARTED TidalConnect services. Jul 22 23:04:00 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:04:00 volumio volumio[4227]: cannot open device 'volumioHw': Device or resource busy Jul 22 23:04:00 volumio volumio[4227]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 22 23:04:00 volumio volumio[4227]: xcb_connection_has_error() returned true Jul 22 23:04:00 volumio volumio[4227]: cannot open device 'volumioHw': Device or resource busy Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp loaded Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 22 23:04:00 volumio volumio[4227]: info: Adding Signal Path Element [object Object] Jul 22 23:04:00 volumio volumio[4227]: info: Updating fusiondspeq DSP Signal Path Element Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp - ---- installed callbackRead Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp - ---- read samplerate, raw: Jul 22 23:04:00 volumio volumio[4227]: error: FusionDsp - invalid sample rate Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp - ---- read samplerate, raw: Jul 22 23:04:00 volumio volumio[4227]: error: FusionDsp - invalid sample rate Jul 22 23:04:00 volumio volumio[4227]: info: Executing endpoint tc_connect Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 22 23:04:00 volumio volumio[4227]: info: Connecting to TidalConnect Jul 22 23:04:00 volumio sudo[15724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 22 23:04:00 volumio sudo[15724]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15729, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 22 23:04:00 volumio volumio[4227]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::servicePushState Jul 22 23:04:00 volumio volumio[4227]: info: CoreStateMachine::pushState Jul 22 23:04:00 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::volumioPushState Jul 22 23:04:00 volumio volumio[4227]: info: MRS: Pushing multiroomSync output update for this device Jul 22 23:04:00 volumio volumio[4227]: info: MRS: Pushing multiroomSync output Jul 22 23:04:00 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:00 volumio volumio[4227]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::servicePushState Jul 22 23:04:00 volumio volumio[4227]: info: CoreStateMachine::pushState Jul 22 23:04:00 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:00 volumio volumio[4227]: info: CoreCommandRouter::volumioPushState Jul 22 23:04:00 volumio volumio[4227]: info: MRS: Pushing multiroomSync output update for this device Jul 22 23:04:00 volumio volumio[4227]: info: MRS: Pushing multiroomSync output Jul 22 23:04:00 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:00 volumio volumio[4227]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Jul 22 23:04:00 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15746, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15753, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15760, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15767, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15774, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15781, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15792, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15804, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:04:00 volumio volumio[4227]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15813, instance 2, run: true Jul 22 23:04:00 volumio sudo[15812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 22 23:04:00 volumio sudo[15812]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:00 volumio sudo[15812]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15828, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15836, instance 2, run: true Jul 22 23:04:00 volumio volumio[4227]: info: camilladsp spawned new process with pid 15843, instance 2, run: true Jul 22 23:04:01 volumio mpd[15649]: Jul 22 23:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 22 23:04:01 volumio systemd[1]: Started Music Player Daemon. Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15850, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:04:01 volumio sudo[15410]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio sudo[15474]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio sudo[15316]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio sudo[15247]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio sudo[15572]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15876, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: error: MPD error: The expression evaluated to a falsy value: Jul 22 23:04:01 volumio volumio[4227]: assert.ok(self.idling) Jul 22 23:04:01 volumio volumio[4227]: error: The expression evaluated to a falsy value: Jul 22 23:04:01 volumio volumio[4227]: assert.ok(self.idling) Jul 22 23:04:01 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:04:01 volumio volumio[4227]: error: MPD error: The expression evaluated to a falsy value: Jul 22 23:04:01 volumio volumio[4227]: assert.ok(self.idling) Jul 22 23:04:01 volumio volumio[4227]: error: The expression evaluated to a falsy value: Jul 22 23:04:01 volumio volumio[4227]: assert.ok(self.idling) Jul 22 23:04:01 volumio volumio[4227]: error: MPD error: The expression evaluated to a falsy value: Jul 22 23:04:01 volumio volumio[4227]: assert.ok(self.idling) Jul 22 23:04:01 volumio volumio[4227]: error: The expression evaluated to a falsy value: Jul 22 23:04:01 volumio volumio[4227]: assert.ok(self.idling) Jul 22 23:04:01 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15887, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15898, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:04:01 volumio volumio[4227]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:04:01 volumio sudo[15906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15907, instance 2, run: true Jul 22 23:04:01 volumio sudo[15906]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:01 volumio sudo[15906]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15922, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15930, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15937, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15944, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15951, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15958, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15965, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15972, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15979, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15986, instance 2, run: true Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 15993, instance 2, run: true Jul 22 23:04:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Jul 22 23:04:01 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:01 volumio volumio[4227]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 23:04:01 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:01 volumio sudo[15724]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:01 volumio volumio[4227]: info: camilladsp spawned new process with pid 16003, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16011, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16018, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16025, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16032, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16039, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16046, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: TidalConnect service stoped! Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16058, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16069, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:04:02 volumio volumio[4227]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 22 23:04:02 volumio sudo[16077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16079, instance 2, run: true Jul 22 23:04:02 volumio sudo[16077]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:02 volumio sudo[16077]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16093, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16101, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: TidalConnect service started! Jul 22 23:04:02 volumio volumio[16000]: Traceback (most recent call last): Jul 22 23:04:02 volumio volumio[16000]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jul 22 23:04:02 volumio volumio[16000]: from camilladsp import CamillaConnection Jul 22 23:04:02 volumio volumio[16000]: ModuleNotFoundError: No module named 'camilladsp' Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16108, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16115, instance 2, run: true Jul 22 23:04:02 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:02 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16122, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16129, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: camilladsp spawned new process with pid 16137, instance 2, run: true Jul 22 23:04:02 volumio volumio[4227]: info: TidalConnect service started! Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16144, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16151, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16158, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16165, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16172, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16179, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16186, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16193, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16200, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16207, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16214, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16221, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16228, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16235, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16242, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16249, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16256, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16263, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: TidalConnect service started! Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16270, instance 2, run: true Jul 22 23:04:03 volumio volumio[4227]: info: camilladsp spawned new process with pid 16277, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16284, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16291, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16298, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16305, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16312, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16319, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16326, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16333, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: TidalConnect service started! Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16340, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16347, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16354, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16361, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16368, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16375, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16382, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16389, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16396, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16403, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16410, instance 2, run: true Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16417, instance 2, run: true Jul 22 23:04:04 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:04 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2. Jul 22 23:04:04 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:04 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:04 volumio volumio[4227]: info: camilladsp spawned new process with pid 16425, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16432, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16439, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16446, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16453, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16460, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16468, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16475, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16482, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16489, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16496, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16503, instance 2, run: true Jul 22 23:04:05 volumio volumio[16424]: Traceback (most recent call last): Jul 22 23:04:05 volumio volumio[16424]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jul 22 23:04:05 volumio volumio[16424]: from camilladsp import CamillaConnection Jul 22 23:04:05 volumio volumio[16424]: ModuleNotFoundError: No module named 'camilladsp' Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16510, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: TidalConnect service started! Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16517, instance 2, run: true Jul 22 23:04:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16524, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16531, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16538, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16545, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16552, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16559, instance 2, run: true Jul 22 23:04:05 volumio volumio[4227]: info: camilladsp spawned new process with pid 16566, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16573, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16580, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16587, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16594, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16601, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16608, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16615, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16622, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16629, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16636, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16643, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16650, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16657, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16664, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16671, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16678, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16685, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16692, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16699, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16706, instance 2, run: true Jul 22 23:04:06 volumio volumio[4227]: info: camilladsp spawned new process with pid 16713, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16720, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16727, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16734, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16741, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16748, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16755, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16762, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16769, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16776, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16784, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16791, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16798, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16805, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16812, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16819, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16826, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16833, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16840, instance 2, run: true Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16847, instance 2, run: true Jul 22 23:04:07 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:07 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 3. Jul 22 23:04:07 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:07 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:07 volumio volumio[4227]: info: camilladsp spawned new process with pid 16855, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16864, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16871, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16878, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16885, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16892, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16899, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16906, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16913, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16920, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16928, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16935, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16942, instance 2, run: true Jul 22 23:04:08 volumio volumio[16854]: Traceback (most recent call last): Jul 22 23:04:08 volumio volumio[16854]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Jul 22 23:04:08 volumio volumio[16854]: from camilladsp import CamillaConnection Jul 22 23:04:08 volumio volumio[16854]: ModuleNotFoundError: No module named 'camilladsp' Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16949, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16956, instance 2, run: true Jul 22 23:04:08 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:08 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16963, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16970, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16979, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16986, instance 2, run: true Jul 22 23:04:08 volumio volumio[4227]: info: camilladsp spawned new process with pid 16993, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17000, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17007, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17014, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17021, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17028, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17035, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17042, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17049, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17056, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17065, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17072, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17079, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17086, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17093, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17100, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17107, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17114, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17121, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17128, instance 2, run: true Jul 22 23:04:09 volumio volumio[4227]: info: camilladsp spawned new process with pid 17135, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17142, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17149, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17156, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17163, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17170, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17177, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17184, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17191, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17198, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17205, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17212, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17219, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17226, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17234, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17241, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17248, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17255, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17262, instance 2, run: true Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17269, instance 2, run: true Jul 22 23:04:10 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:10 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 4. Jul 22 23:04:10 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:10 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:10 volumio volumio[4227]: info: camilladsp spawned new process with pid 17277, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17284, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17292, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17299, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17306, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17313, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17320, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17327, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17334, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17341, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17348, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17355, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17362, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17369, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17376, instance 2, run: true Jul 22 23:04:11 volumio volumio[17276]: Traceback (most recent call last): Jul 22 23:04:11 volumio volumio[17276]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jul 22 23:04:11 volumio volumio[17276]: from camilladsp_plot.validate_config import CamillaValidator Jul 22 23:04:11 volumio volumio[17276]: ModuleNotFoundError: No module named 'camilladsp_plot' Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17383, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17390, instance 2, run: true Jul 22 23:04:11 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:11 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17397, instance 2, run: true Jul 22 23:04:11 volumio volumio[4227]: info: camilladsp spawned new process with pid 17404, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17411, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17418, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17425, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17432, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17439, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17446, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17453, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17460, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17467, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17474, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17481, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17488, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17495, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17502, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17509, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17516, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17523, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17530, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17537, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17544, instance 2, run: true Jul 22 23:04:12 volumio volumio[4227]: info: camilladsp spawned new process with pid 17551, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17558, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17565, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17572, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17579, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17586, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17593, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17600, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17607, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17614, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17621, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17628, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17635, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17642, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17649, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17656, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17663, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17670, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17677, instance 2, run: true Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17684, instance 2, run: true Jul 22 23:04:13 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:13 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 5. Jul 22 23:04:13 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:13 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:13 volumio volumio[4227]: info: camilladsp spawned new process with pid 17692, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17699, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17706, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17713, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17720, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17727, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17734, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17741, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17748, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17755, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17762, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17769, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17776, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17783, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17790, instance 2, run: true Jul 22 23:04:14 volumio volumio[17691]: Traceback (most recent call last): Jul 22 23:04:14 volumio volumio[17691]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jul 22 23:04:14 volumio volumio[17691]: from camilladsp_plot.validate_config import CamillaValidator Jul 22 23:04:14 volumio volumio[17691]: ModuleNotFoundError: No module named 'camilladsp_plot' Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17797, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17804, instance 2, run: true Jul 22 23:04:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17812, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17819, instance 2, run: true Jul 22 23:04:14 volumio volumio[4227]: info: camilladsp spawned new process with pid 17826, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17836, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17845, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17853, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17860, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17867, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17874, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17881, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17888, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17895, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17902, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17909, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17916, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17923, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17931, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17938, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17945, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17954, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17961, instance 2, run: true Jul 22 23:04:15 volumio volumio[4227]: info: camilladsp spawned new process with pid 17972, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 17982, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 17990, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 17997, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18004, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18011, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18018, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18025, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18032, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18039, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18046, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18053, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18062, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18069, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18076, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18083, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18090, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18097, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18104, instance 2, run: true Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18111, instance 2, run: true Jul 22 23:04:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 6. Jul 22 23:04:16 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:16 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:16 volumio volumio[4227]: info: camilladsp spawned new process with pid 18118, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18126, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18133, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18140, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18147, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18154, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18161, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: CoreCommandRouter::volumioPlay Jul 22 23:04:17 volumio volumio[4227]: info: CoreStateMachine::play index undefined Jul 22 23:04:17 volumio volumio[4227]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 23:04:17 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:17 volumio volumio[4227]: info: CoreStateMachine::startPlaybackTimer Jul 22 23:04:17 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:17 volumio volumio[4227]: info: CoreCommandRouter::volumioGetVisibleSources Jul 22 23:04:17 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 23:04:17 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 22 23:04:17 volumio volumio[4227]: info: [1721682257302] ControllerWebradio::clearAddPlayTrack Jul 22 23:04:17 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 23:04:17 volumio volumio[4227]: info: sendMpdCommand stop took 2 milliseconds Jul 22 23:04:17 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand clear Jul 22 23:04:17 volumio volumio[4227]: info: Jul 22 23:04:17 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:17 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:17 volumio volumio[4227]: info: sendMpdCommand clear took 3 milliseconds Jul 22 23:04:17 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand load "France musique.midfi mp3" Jul 22 23:04:17 volumio volumio[4227]: info: Jul 22 23:04:17 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:17 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:17 volumio volumio[4227]: info: Jul 22 23:04:17 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:17 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:17 volumio volumio[4227]: info: Jul 22 23:04:17 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:17 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:17 volumio volumio[4227]: info: Jul 22 23:04:17 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:17 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:17 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:17 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:17 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:17 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:17 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:17 volumio volumio[4227]: info: ------------------------------ 10ms Jul 22 23:04:17 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand add "France musique.midfi mp3" Jul 22 23:04:17 volumio volumio[4227]: info: ------------------------------ 8ms Jul 22 23:04:17 volumio volumio[4227]: info: ------------------------------ 6ms Jul 22 23:04:17 volumio volumio[4227]: info: ------------------------------ 5ms Jul 22 23:04:17 volumio volumio[4227]: info: ------------------------------ 4ms Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18168, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18175, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18182, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18189, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18196, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18203, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18210, instance 2, run: true Jul 22 23:04:17 volumio volumio[18119]: Traceback (most recent call last): Jul 22 23:04:17 volumio volumio[18119]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jul 22 23:04:17 volumio volumio[18119]: from camilladsp_plot.validate_config import CamillaValidator Jul 22 23:04:17 volumio volumio[18119]: ModuleNotFoundError: No module named 'camilladsp_plot' Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18217, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18224, instance 2, run: true Jul 22 23:04:17 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:17 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18231, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18238, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18245, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18252, instance 2, run: true Jul 22 23:04:17 volumio volumio[4227]: info: camilladsp spawned new process with pid 18259, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18266, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18273, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18280, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18287, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18294, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18301, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18308, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18315, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18322, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18329, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18336, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18343, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18350, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18357, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18364, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18371, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18378, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18385, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18392, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18399, instance 2, run: true Jul 22 23:04:18 volumio volumio[4227]: info: camilladsp spawned new process with pid 18406, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18413, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18420, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18427, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18434, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18441, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18448, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18455, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18462, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18469, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18476, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18483, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18490, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18497, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18504, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18511, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18518, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18525, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18532, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18539, instance 2, run: true Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18546, instance 2, run: true Jul 22 23:04:19 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:19 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 7. Jul 22 23:04:19 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:19 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:19 volumio volumio[4227]: info: camilladsp spawned new process with pid 18554, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18561, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18568, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18575, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18582, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18591, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18609, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18631, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18654, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18673, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18681, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18688, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18695, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18702, instance 2, run: true Jul 22 23:04:20 volumio volumio[18553]: Traceback (most recent call last): Jul 22 23:04:20 volumio volumio[18553]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jul 22 23:04:20 volumio volumio[18553]: from camilladsp_plot.validate_config import CamillaValidator Jul 22 23:04:20 volumio volumio[18553]: ModuleNotFoundError: No module named 'camilladsp_plot' Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18709, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18716, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18723, instance 2, run: true Jul 22 23:04:20 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jul 22 23:04:20 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18730, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18737, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18744, instance 2, run: true Jul 22 23:04:20 volumio volumio[4227]: info: camilladsp spawned new process with pid 18753, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18760, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18767, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18774, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18781, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18788, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18795, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: CoreCommandRouter::volumioPlay Jul 22 23:04:21 volumio volumio[4227]: info: CoreStateMachine::play index undefined Jul 22 23:04:21 volumio volumio[4227]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 23:04:21 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:21 volumio volumio[4227]: info: CoreStateMachine::startPlaybackTimer Jul 22 23:04:21 volumio volumio[4227]: info: CorePlayQueue::getTrack 0 Jul 22 23:04:21 volumio volumio[4227]: info: CoreCommandRouter::volumioGetVisibleSources Jul 22 23:04:21 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 22 23:04:21 volumio volumio[4227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 22 23:04:21 volumio volumio[4227]: info: [1721682261284] ControllerWebradio::clearAddPlayTrack Jul 22 23:04:21 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 23:04:21 volumio volumio[4227]: info: sendMpdCommand stop took 1 milliseconds Jul 22 23:04:21 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand clear Jul 22 23:04:21 volumio volumio[4227]: info: Jul 22 23:04:21 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:21 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:21 volumio volumio[4227]: info: sendMpdCommand clear took 1 milliseconds Jul 22 23:04:21 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand load "France musique.midfi mp3" Jul 22 23:04:21 volumio volumio[4227]: info: Jul 22 23:04:21 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:21 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:21 volumio volumio[4227]: info: Jul 22 23:04:21 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:21 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:21 volumio volumio[4227]: info: Jul 22 23:04:21 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:21 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:21 volumio volumio[4227]: info: Jul 22 23:04:21 volumio volumio[4227]: ---------------------------- MPD announces system playlist update Jul 22 23:04:21 volumio volumio[4227]: info: Ignoring MPD Status Update Jul 22 23:04:21 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:21 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:21 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:21 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:21 volumio volumio[4227]: error: updateQueue error: null Jul 22 23:04:21 volumio volumio[4227]: info: ------------------------------ 14ms Jul 22 23:04:21 volumio volumio[4227]: verbose: ControllerMpd::sendMpdCommand add "France musique.midfi mp3" Jul 22 23:04:21 volumio volumio[4227]: info: ------------------------------ 12ms Jul 22 23:04:21 volumio volumio[4227]: info: ------------------------------ 11ms Jul 22 23:04:21 volumio volumio[4227]: info: ------------------------------ 11ms Jul 22 23:04:21 volumio volumio[4227]: info: ------------------------------ 10ms Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18802, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18809, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18816, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18823, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18830, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18837, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18844, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18851, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18858, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18865, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18872, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18879, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18886, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18893, instance 2, run: true Jul 22 23:04:21 volumio volumio[4227]: info: camilladsp spawned new process with pid 18900, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18907, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18914, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18921, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18928, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18935, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18942, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18949, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18956, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18963, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18970, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18977, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18984, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18991, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 18998, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 19005, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 19012, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 19019, instance 2, run: true Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 19026, instance 2, run: true Jul 22 23:04:22 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jul 22 23:04:22 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 8. Jul 22 23:04:22 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 22 23:04:22 volumio systemd[1]: Started FusionDsp Daemon. Jul 22 23:04:22 volumio volumio[4227]: info: camilladsp spawned new process with pid 19033, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19041, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19052, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19059, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19066, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19073, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19080, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19087, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19094, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19101, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19108, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19115, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19122, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19129, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19136, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19143, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19150, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19157, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19166, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19173, instance 2, run: true Jul 22 23:04:23 volumio volumio[4227]: info: camilladsp spawned new process with pid 19180, instance 2, run: true Jul 22 23:04:24 volumio volumio[4227]: info: camilladsp spawned new process with pid 19187, instance 2, run: true Jul 22 23:04:24 volumio volumio[4227]: info: camilladsp spawned new process with pid undefined, instance 2, run: true Jul 22 23:04:24 volumio volumio[4227]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 23:04:24 volumio volumio[4227]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES Jul 22 23:04:24 volumio volumio[4227]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jul 22 23:04:24 volumio volumio[4227]: at onErrorNT (internal/child_process.js:472:16) Jul 22 23:04:24 volumio volumio[4227]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Jul 22 23:04:24 volumio volumio[4227]: errno: -13, Jul 22 23:04:24 volumio volumio[4227]: code: 'EACCES', Jul 22 23:04:24 volumio volumio[4227]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 22 23:04:24 volumio volumio[4227]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 22 23:04:24 volumio volumio[4227]: spawnargs: [ Jul 22 23:04:24 volumio volumio[4227]: '-p', Jul 22 23:04:24 volumio volumio[4227]: 9876, Jul 22 23:04:24 volumio volumio[4227]: '-o', Jul 22 23:04:24 volumio volumio[4227]: '/tmp/camilladsp.log', Jul 22 23:04:24 volumio volumio[4227]: '-l', Jul 22 23:04:24 volumio volumio[4227]: 'warn', Jul 22 23:04:24 volumio volumio[4227]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 22 23:04:24 volumio volumio[4227]: ] Jul 22 23:04:24 volumio volumio[4227]: } Jul 22 23:04:24 volumio volumio[4227]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 23:04:24 volumio sudo[19202]: 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 Jul 22 23:04:24 volumio sudo[19202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:24 volumio sudo[19202]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:24 volumio sudo[19216]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Jul 22 23:04:24 volumio sudo[19216]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:24 volumio sudo[19216]: pam_unix(sudo:session): session closed for user root Jul 22 23:04:24 volumio sudo[19226]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Jul 22 23:04:24 volumio sudo[19226]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 23:04:24 volumio sudo[19235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 23:03 Jul 22 23:04:24 volumio sudo[19235]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:59:47 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="5afa2cba9d125c5d0103869143516973"