-- Logs begin at Thu 2019-02-14 04:11:58 CST, end at Wed 2025-12-24 12:57:47 CST. -- Dec 24 12:56:01 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:01-06:00" level=debug msg="fetched chunk 13/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:56:02 volumiojg1 volumio[1115]: info: Selecting previously unselected package libpython3-dev:armhf. Dec 24 12:56:02 volumiojg1 volumio[1115]: info: Preparing to unpack .../28-libpython3-dev_3.7.3-1_armhf.deb ... Dec 24 12:56:02 volumiojg1 volumio[1115]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ... Dec 24 12:56:02 volumiojg1 volumio[1115]: info: Selecting previously unselected package python-pip-whl. Dec 24 12:56:02 volumiojg1 volumio[1115]: info: Preparing to unpack .../29-python-pip-whl_18.1-5+rpt1_all.deb ... Dec 24 12:56:03 volumiojg1 volumio[1115]: info: Unpacking python-pip-whl (18.1-5+rpt1) ... Dec 24 12:56:04 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-multidict. Dec 24 12:56:04 volumiojg1 volumio[1115]: info: Preparing to unpack .../30-python3-multidict_4.5.2-1_armhf.deb ... Dec 24 12:56:04 volumiojg1 volumio[1115]: info: Unpacking python3-multidict (4.5.2-1) ... Dec 24 12:56:04 volumiojg1 ntpd[772]: 172.235.154.118 local addr 192.168.1.189 -> Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-yarl. Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Preparing to unpack .../31-python3-yarl_1.3.0-1_armhf.deb ... Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Unpacking python3-yarl (1.3.0-1) ... Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-async-timeout. Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Preparing to unpack .../32-python3-async-timeout_3.0.1-1_all.deb ... Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Unpacking python3-async-timeout (3.0.1-1) ... Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-attr. Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Preparing to unpack .../33-python3-attr_18.2.0-1_all.deb ... Dec 24 12:56:05 volumiojg1 volumio[1115]: info: Unpacking python3-attr (18.2.0-1) ... Dec 24 12:56:06 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-aiohttp. Dec 24 12:56:06 volumiojg1 volumio[1115]: info: Preparing to unpack .../34-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Dec 24 12:56:06 volumiojg1 volumio[1115]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Dec 24 12:56:08 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-asn1crypto. Dec 24 12:56:08 volumiojg1 volumio[1115]: info: Preparing to unpack .../35-python3-asn1crypto_0.24.0-1_all.deb ... Dec 24 12:56:08 volumiojg1 volumio[1115]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Dec 24 12:56:09 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-cffi-backend. Dec 24 12:56:09 volumiojg1 volumio[1115]: info: Preparing to unpack .../36-python3-cffi-backend_1.12.2-1_armhf.deb ... Dec 24 12:56:09 volumiojg1 volumio[1115]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Dec 24 12:56:09 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-crypto. Dec 24 12:56:09 volumiojg1 volumio[1115]: info: Preparing to unpack .../37-python3-crypto_2.6.1-9+b1_armhf.deb ... Dec 24 12:56:10 volumiojg1 volumio[1115]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Dec 24 12:56:13 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-cryptography. Dec 24 12:56:13 volumiojg1 volumio[1115]: info: Preparing to unpack .../38-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ... Dec 24 12:56:13 volumiojg1 volumio[1115]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ... Dec 24 12:56:13 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:13-06:00" level=debug msg="fetched chunk 14/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:56:15 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-dbus. Dec 24 12:56:15 volumiojg1 volumio[1115]: info: Preparing to unpack .../39-python3-dbus_1.2.8-3_armhf.deb ... Dec 24 12:56:15 volumiojg1 volumio[1115]: info: Unpacking python3-dbus (1.2.8-3) ... Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3.7-dev. Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Dec 24 12:56:17 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:17-06:00" level=trace msg="sent dealer ping" Dec 24 12:56:17 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:17-06:00" level=trace msg="received dealer pong" Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-dev. Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Unpacking python3-dev (3.7.3-1) ... Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-entrypoints. Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Dec 24 12:56:17 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:17-06:00" level=trace msg="received accesspoint ping" Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Unpacking python3-entrypoints (0.3-1) ... Dec 24 12:56:17 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:17-06:00" level=trace msg="received accesspoint pong ack" Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-gi. Dec 24 12:56:17 volumiojg1 volumio[1115]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Dec 24 12:56:18 volumiojg1 volumio[1115]: info: Unpacking python3-gi (3.30.4-1) ... Dec 24 12:56:18 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-secretstorage. Dec 24 12:56:19 volumiojg1 volumio[1115]: info: Preparing to unpack .../44-python3-secretstorage_2.3.1-2_all.deb ... Dec 24 12:56:19 volumiojg1 volumio[1115]: info: Unpacking python3-secretstorage (2.3.1-2) ... Dec 24 12:56:20 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-keyring. Dec 24 12:56:20 volumiojg1 volumio[1115]: info: Preparing to unpack .../45-python3-keyring_17.1.1-1_all.deb ... Dec 24 12:56:20 volumiojg1 volumio[1115]: info: Unpacking python3-keyring (17.1.1-1) ... Dec 24 12:56:21 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-keyrings.alt. Dec 24 12:56:21 volumiojg1 volumio[1115]: info: Preparing to unpack .../46-python3-keyrings.alt_3.1.1-1_all.deb ... Dec 24 12:56:21 volumiojg1 volumio[1115]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Dec 24 12:56:21 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-pip. Dec 24 12:56:21 volumiojg1 volumio[1115]: info: Preparing to unpack .../47-python3-pip_18.1-5+rpt1_all.deb ... Dec 24 12:56:21 volumiojg1 volumio[1115]: info: Unpacking python3-pip (18.1-5+rpt1) ... Dec 24 12:56:24 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-setuptools. Dec 24 12:56:24 volumiojg1 volumio[1115]: info: Preparing to unpack .../48-python3-setuptools_40.8.0-1_all.deb ... Dec 24 12:56:24 volumiojg1 volumio[1115]: info: Unpacking python3-setuptools (40.8.0-1) ... Dec 24 12:56:26 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:26-06:00" level=debug msg="fetched chunk 15/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:56:26 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-wheel. Dec 24 12:56:26 volumiojg1 volumio[1115]: info: Preparing to unpack .../49-python3-wheel_0.32.3-2_all.deb ... Dec 24 12:56:26 volumiojg1 volumio[1115]: info: Unpacking python3-wheel (0.32.3-2) ... Dec 24 12:56:26 volumiojg1 volumio[1115]: info: Selecting previously unselected package python3-xdg. Dec 24 12:56:26 volumiojg1 volumio[1115]: info: Preparing to unpack .../50-python3-xdg_0.25-5_all.deb ... Dec 24 12:56:27 volumiojg1 volumio[1115]: info: Unpacking python3-xdg (0.25-5) ... Dec 24 12:56:28 volumiojg1 volumio[1115]: info: Setting up python3-entrypoints (0.3-1) ... Dec 24 12:56:28 volumiojg1 volumio[1115]: info: Setting up dh-python (3.20190308) ... Dec 24 12:56:29 volumiojg1 volumio[1115]: info: Setting up python3-attr (18.2.0-1) ... Dec 24 12:56:29 volumiojg1 volumio[1115]: info: Setting up python3-dbus (1.2.8-3) ... Dec 24 12:56:30 volumiojg1 volumio[1115]: info: Setting up python3-setuptools (40.8.0-1) ... Dec 24 12:56:31 volumiojg1 volumio[1115]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Dec 24 12:56:31 volumiojg1 volumio[1115]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Dec 24 12:56:31 volumiojg1 volumio[1115]: info: Setting up python3-xdg (0.25-5) ... Dec 24 12:56:31 volumiojg1 ntpd[772]: 162.244.81.139 local addr 192.168.1.189 -> Dec 24 12:56:31 volumiojg1 volumio[1115]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Dec 24 12:56:32 volumiojg1 volumio[1115]: info: Setting up python3-wheel (0.32.3-2) ... Dec 24 12:56:32 volumiojg1 volumio[1115]: info: Setting up python3-multidict (4.5.2-1) ... Dec 24 12:56:33 volumiojg1 volumio[1115]: info: Setting up libfakeroot:armhf (1.23-1) ... Dec 24 12:56:33 volumiojg1 volumio[1115]: info: Setting up python3-async-timeout (3.0.1-1) ... Dec 24 12:56:33 volumiojg1 volumio[1115]: info: Setting up fakeroot (1.23-1) ... Dec 24 12:56:33 volumiojg1 ntpd[772]: 173.208.172.164 local addr 192.168.1.189 -> Dec 24 12:56:34 volumiojg1 volumio[1115]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Dec 24 12:56:34 volumiojg1 volumio[1115]: 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 Dec 24 12:56:34 volumiojg1 volumio[1115]: 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 Dec 24 12:56:34 volumiojg1 volumio[1115]: 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 Dec 24 12:56:34 volumiojg1 volumio[1115]: 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 Dec 24 12:56:34 volumiojg1 volumio[1115]: 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 Dec 24 12:56:34 volumiojg1 volumio[1115]: 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 Dec 24 12:56:34 volumiojg1 systemd[1]: Starting Cleanup of Temporary Directories... Dec 24 12:56:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:56:34 volumiojg1 volumio[1115]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Dec 24 12:56:34 volumiojg1 volumio[1115]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Dec 24 12:56:34 volumiojg1 volumio[1115]: info: Setting up make (4.2.1-1.2) ... Dec 24 12:56:34 volumiojg1 volumio[1115]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Dec 24 12:56:34 volumiojg1 systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Dec 24 12:56:34 volumiojg1 systemd[1]: Started Cleanup of Temporary Directories. Dec 24 12:56:34 volumiojg1 volumio[1115]: info: Setting up python3-gi (3.30.4-1) ... Dec 24 12:56:35 volumiojg1 volumio[1115]: info: Setting up libmpc3:armhf (1.1.0-1) ... Dec 24 12:56:35 volumiojg1 volumio[1115]: info: Setting up patch (2.7.6-3+deb10u1) ... Dec 24 12:56:35 volumiojg1 volumio[1115]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Dec 24 12:56:35 volumiojg1 volumio[1115]: info: Setting up libisl19:armhf (0.20-2) ... Dec 24 12:56:35 volumiojg1 volumio[1115]: info: Setting up python3-crypto (2.6.1-9+b1) ... Dec 24 12:56:36 volumiojg1 volumio[1115]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Dec 24 12:56:36 volumiojg1 volumio[1115]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Dec 24 12:56:36 volumiojg1 volumio[1115]: info: Setting up python3-yarl (1.3.0-1) ... Dec 24 12:56:37 volumiojg1 volumio[1115]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Dec 24 12:56:37 volumiojg1 volumio[1115]: info: Setting up python3-asn1crypto (0.24.0-1) ... Dec 24 12:56:37 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:37-06:00" level=debug msg="fetched chunk 16/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:56:38 volumiojg1 volumio[1115]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Dec 24 12:56:38 volumiojg1 volumio[1115]: info: Setting up python3-cffi-backend (1.12.2-1) ... Dec 24 12:56:39 volumiojg1 volumio[1115]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Dec 24 12:56:39 volumiojg1 volumio[1115]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Dec 24 12:56:39 volumiojg1 volumio[1115]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Dec 24 12:56:39 volumiojg1 volumio[1115]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Dec 24 12:56:40 volumiojg1 volumio[1115]: info: Setting up dpkg-dev (1.19.8) ... Dec 24 12:56:40 volumiojg1 volumio[1115]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Dec 24 12:56:41 volumiojg1 volumio[1115]: info: Setting up python3-pip (18.1-5+rpt1) ... Dec 24 12:56:41 volumiojg1 volumio[1115]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Dec 24 12:56:41 volumiojg1 volumio[1115]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Dec 24 12:56:41 volumiojg1 volumio[1115]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Dec 24 12:56:42 volumiojg1 volumio[1115]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Dec 24 12:56:42 volumiojg1 volumio[1115]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Dec 24 12:56:42 volumiojg1 volumio[1115]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Dec 24 12:56:42 volumiojg1 volumio[1115]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Dec 24 12:56:42 volumiojg1 volumio[1115]: info: Setting up python3-secretstorage (2.3.1-2) ... Dec 24 12:56:43 volumiojg1 volumio[1115]: info: Setting up python3-dev (3.7.3-1) ... Dec 24 12:56:43 volumiojg1 volumio[1115]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Dec 24 12:56:44 volumiojg1 volumio[1115]: info: Setting up python3-keyring (17.1.1-1) ... Dec 24 12:56:44 volumiojg1 volumio[1115]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Dec 24 12:56:44 volumiojg1 volumio[1115]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Dec 24 12:56:44 volumiojg1 volumio[1115]: info: Setting up build-essential (12.6) ... Dec 24 12:56:44 volumiojg1 volumio[1115]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Dec 24 12:56:46 volumiojg1 sudo[3694]: pam_unix(sudo:session): session closed for user root Dec 24 12:56:46 volumiojg1 sudo[4711]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Dec 24 12:56:46 volumiojg1 sudo[4711]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:56:46 volumiojg1 volumio[1115]: info: lib/systemd/system/fusiondsp.service Dec 24 12:56:46 volumiojg1 sudo[4711]: pam_unix(sudo:session): session closed for user root Dec 24 12:56:47 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:47-06:00" level=trace msg="sent dealer ping" Dec 24 12:56:47 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:47-06:00" level=trace msg="received dealer pong" Dec 24 12:56:48 volumiojg1 volumio[1115]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Dec 24 12:56:48 volumiojg1 volumio[1115]: info: more info at http://www.winimage.com/zLibDll/unzip.html Dec 24 12:56:48 volumiojg1 volumio[1115]: info: Dec 24 12:56:48 volumiojg1 volumio[1115]: info: cgui-1.0.0.zip opened Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/LICENSE.txt Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/README.md Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/build/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/robots.txt Dec 24 12:56:48 volumiojg1 sudo[4715]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/logo512.png Dec 24 12:56:48 volumiojg1 sudo[4715]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/asset-manifest.json Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/index.html Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/.put_statics_here Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/favicon.ico Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/logo192.png Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/manifest.json Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/css-variables.css Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/service-worker.js Dec 24 12:56:48 volumiojg1 sudo[4715]: pam_unix(sudo:session): session closed for user root Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/build/static/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/build/static/css/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/main.1503f6cd.css Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/build/static/media/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/build/static/js/ Dec 24 12:56:48 volumiojg1 sudo[4717]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Dec 24 12:56:48 volumiojg1 sudo[4717]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.71e11955.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Dec 24 12:56:48 volumiojg1 sudo[4717]: pam_unix(sudo:session): session closed for user root Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.71e11955.js.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/config/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/config/camillagui.yml Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/config/gui-config.yml Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/backend/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/filters_test.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/version.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/filters.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/settings.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/views.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/filterdefaults.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__init__.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: creating directory: cgui/backend/__pycache__/ Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Dec 24 12:56:48 volumiojg1 sudo[4719]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Dec 24 12:56:48 volumiojg1 sudo[4719]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/routes.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/backend/filemanagement.py Dec 24 12:56:48 volumiojg1 volumio[1115]: info: extracting: cgui/main.py Dec 24 12:56:48 volumiojg1 sudo[4719]: pam_unix(sudo:session): session closed for user root Dec 24 12:56:49 volumiojg1 go-librespot[1292]: time="2025-12-24T12:56:49-06:00" level=debug msg="fetched chunk 17/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:56:59 volumiojg1 volumio[1115]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Dec 24 12:56:59 volumiojg1 volumio[1115]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Dec 24 12:56:59 volumiojg1 volumio[1115]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-6coblq33 Dec 24 12:57:01 volumiojg1 volumio[1115]: info: Collecting PyYAML (from camilladsp==1.0.0) Dec 24 12:57:01 volumiojg1 go-librespot[1292]: time="2025-12-24T12:57:01-06:00" level=debug msg="fetched chunk 18/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:57:03 volumiojg1 volumio[1115]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Dec 24 12:57:03 volumiojg1 volumio[1115]: info: Collecting websocket_client (from camilladsp==1.0.0) Dec 24 12:57:04 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Dec 24 12:57:04 volumiojg1 volumio[1115]: info: Building wheels for collected packages: camilladsp Dec 24 12:57:04 volumiojg1 volumio[1115]: info: Running setup.py bdist_wheel for camilladsp: started Dec 24 12:57:05 volumiojg1 volumio[1115]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Dec 24 12:57:05 volumiojg1 volumio[1115]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-zwdz0z3k/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Dec 24 12:57:05 volumiojg1 volumio[1115]: info: Successfully built camilladsp Dec 24 12:57:05 volumiojg1 volumio[1115]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Dec 24 12:57:05 volumiojg1 volumio[1115]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Dec 24 12:57:08 volumiojg1 volumio[1115]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Dec 24 12:57:08 volumiojg1 volumio[1115]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Dec 24 12:57:08 volumiojg1 volumio[1115]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-i1b8k45f Dec 24 12:57:10 volumiojg1 volumio[1115]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Dec 24 12:57:10 volumiojg1 volumio[1115]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Dec 24 12:57:11 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Dec 24 12:57:11 volumiojg1 volumio[1115]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Dec 24 12:57:11 volumiojg1 volumio[1115]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Dec 24 12:57:13 volumiojg1 volumio[1115]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Dec 24 12:57:13 volumiojg1 go-librespot[1292]: time="2025-12-24T12:57:13-06:00" level=debug msg="fetched chunk 19/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:57:13 volumiojg1 volumio[1115]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Dec 24 12:57:14 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Dec 24 12:57:14 volumiojg1 volumio[1115]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Dec 24 12:57:14 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Dec 24 12:57:14 volumiojg1 volumio[1115]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Dec 24 12:57:15 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Dec 24 12:57:15 volumiojg1 volumio[1115]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Dec 24 12:57:16 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Dec 24 12:57:16 volumiojg1 volumio[1115]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Dec 24 12:57:16 volumiojg1 volumio[1115]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Dec 24 12:57:16 volumiojg1 volumio[1115]: info: Building wheels for collected packages: camilladsp-plot Dec 24 12:57:16 volumiojg1 volumio[1115]: info: Running setup.py bdist_wheel for camilladsp-plot: started Dec 24 12:57:17 volumiojg1 go-librespot[1292]: time="2025-12-24T12:57:17-06:00" level=trace msg="sent dealer ping" Dec 24 12:57:17 volumiojg1 go-librespot[1292]: time="2025-12-24T12:57:17-06:00" level=trace msg="received dealer pong" Dec 24 12:57:17 volumiojg1 volumio[1115]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Dec 24 12:57:17 volumiojg1 volumio[1115]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-n5uec45k/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Dec 24 12:57:17 volumiojg1 volumio[1115]: info: Successfully built camilladsp-plot Dec 24 12:57:18 volumiojg1 volumio[1115]: info: Installing collected packages: pyrsistent, zipp, importlib-resources, typing-extensions, importlib-metadata, pkgutil-resolve-name, jsonschema, camilladsp-plot Dec 24 12:57:18 volumiojg1 volumio[1115]: info: Successfully installed camilladsp-plot-1.0.2 importlib-metadata-6.7.0 importlib-resources-5.12.0 jsonschema-4.17.3 pkgutil-resolve-name-1.3.10 pyrsistent-0.19.3 typing-extensions-4.7.1 zipp-3.15.0 Dec 24 12:57:18 volumiojg1 volumio[1115]: info: copying hw detection script Dec 24 12:57:18 volumiojg1 volumio[1115]: info: Detected cpu architecture as armv7l Dec 24 12:57:19 volumiojg1 sudo[4890]: 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 Dec 24 12:57:19 volumiojg1 sudo[4890]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:19 volumiojg1 sudo[4890]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:19 volumiojg1 sudo[4892]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Dec 24 12:57:19 volumiojg1 sudo[4892]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:19 volumiojg1 sudo[4892]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:19 volumiojg1 sudo[4894]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Dec 24 12:57:19 volumiojg1 sudo[4894]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:20 volumiojg1 volumio[1115]: info: Reading package lists... Dec 24 12:57:20 volumiojg1 volumio[1115]: info: Building dependency tree... Dec 24 12:57:20 volumiojg1 volumio[1115]: info: Reading state information... Dec 24 12:57:21 volumiojg1 volumio[1115]: info: The following NEW packages will be installed: Dec 24 12:57:21 volumiojg1 volumio[1115]: info: drc Dec 24 12:57:22 volumiojg1 volumio[1115]: info: 0 upgraded, 1 newly installed, 0 to remove and 2 not upgraded. Dec 24 12:57:22 volumiojg1 volumio[1115]: info: Need to get 112 kB of archives. Dec 24 12:57:22 volumiojg1 volumio[1115]: info: After this operation, 512 kB of additional disk space will be used. Dec 24 12:57:22 volumiojg1 volumio[1115]: info: Get:1 https://apt2.volumio.org/raspbian buster/main armhf drc armhf 3.2.2~dfsg0-2 [112 kB] Dec 24 12:57:23 volumiojg1 volumio[1115]: info: Fetched 112 kB in 1s (76.8 kB/s) Dec 24 12:57:23 volumiojg1 volumio[1115]: info: Selecting previously unselected package drc. Dec 24 12:57:23 volumiojg1 volumio[1115]: [169B blob data] Dec 24 12:57:23 volumiojg1 volumio[1115]: [147B blob data] Dec 24 12:57:23 volumiojg1 volumio[1115]: [176B blob data] Dec 24 12:57:23 volumiojg1 volumio[1115]: info: dpkg: warning: files list file for package 'bluetooth' missing; assuming package has no files currently installed Dec 24 12:57:23 volumiojg1 volumio[1115]: [494B blob data] Dec 24 12:57:23 volumiojg1 volumio[1115]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Dec 24 12:57:23 volumiojg1 volumio[1115]: info: Unpacking drc (3.2.2~dfsg0-2) ... Dec 24 12:57:25 volumiojg1 go-librespot[1292]: time="2025-12-24T12:57:25-06:00" level=debug msg="fetched chunk 20/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:57:26 volumiojg1 volumio[1115]: info: Setting up drc (3.2.2~dfsg0-2) ... Dec 24 12:57:27 volumiojg1 sudo[4894]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:27 volumiojg1 sudo[3430]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:27 volumiojg1 volumio[1115]: Plugin install end detected on script Dec 24 12:57:27 volumiojg1 volumio[1115]: info: Install script completed Dec 24 12:57:27 volumiojg1 volumio[1115]: info: Adding reference to registry Dec 24 12:57:27 volumiojg1 volumio[1115]: info: Done installing plugin. Dec 24 12:57:27 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 24 12:57:27 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 24 12:57:27 volumiojg1 volumio[1115]: info: Folder /tmp/plugins removed Dec 24 12:57:27 volumiojg1 volumio[1115]: info: Folder /tmp/downloaded_plugin.zip removed Dec 24 12:57:28 volumiojg1 volumio[1115]: info: Folder /data/temp removed Dec 24 12:57:33 volumiojg1 volumio[1115]: info: Enabling plugin fusiondsp Dec 24 12:57:33 volumiojg1 volumio[1115]: info: Loading plugin "fusiondsp"... Dec 24 12:57:33 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:33 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:33 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:33 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:33 volumiojg1 volumio[1115]: info: Asound.conf file written Dec 24 12:57:33 volumiojg1 sudo[4958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 24 12:57:33 volumiojg1 sudo[4958]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:33 volumiojg1 sudo[4958]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:33 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:33 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:34 volumiojg1 sudo[4963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:34 volumiojg1 sudo[4963]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[4963]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:34 volumiojg1 sudo[4966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:34 volumiojg1 sudo[4966]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 systemd[1]: Stopping Music Player Daemon... Dec 24 12:57:34 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:34 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:34 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:34 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:34 volumiojg1 vtcs[1660]: [2025-12-24 12:57:34.093] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 24 12:57:34 volumiojg1 vtcs[1660]: [2025-12-24 12:57:34.094] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Dec 24 12:57:34 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:34 volumiojg1 vtcs[1660]: [2025-12-24 12:57:34.094] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 24 12:57:34 volumiojg1 volumio[1115]: info: PLUGIN START: fusiondsp Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Loading i18n strings for locale en Dec 24 12:57:34 volumiojg1 sudo[4975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:34 volumiojg1 sudo[4975]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: FusionDsp - mixtype--------------------- Hardware Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:34 volumiojg1 systemd[1]: Stopping Volumio Tidal Connect Service... Dec 24 12:57:34 volumiojg1 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:34 volumiojg1 systemd[1]: vtcs.service: Succeeded. Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Done. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Volumio Tidal Connect Service. Dec 24 12:57:34 volumiojg1 sudo[4975]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[4971]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:34 volumiojg1 sudo[4971]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[4971]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[4979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:34 volumiojg1 sudo[4979]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[4979]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:34 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:34 volumiojg1 sudo[4988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:34 volumiojg1 sudo[4988]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 sudo[4988]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:34 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:34 volumiojg1 sudo[4990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 sudo[4990]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:34 volumiojg1 qobuz-connect[1621]: 20251224 12:57:34.304 [1621.1621] INFO SampleApp: Stopping Local configuration server Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 qobuz-connect[1621]: 20251224 12:57:34.315 [1621.1621] INFO SampleApp: shat down connection on UNIX socket Dec 24 12:57:34 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 24 12:57:34 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:34 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:34 volumiojg1 sudo[4990]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[4998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:34 volumiojg1 sudo[4998]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Asound.conf file unchanged, so no further update is needed Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:34 volumiojg1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 24 12:57:34 volumiojg1 systemd[1]: shairport-sync.service: Succeeded. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:34 volumiojg1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:34 volumiojg1 sudo[4998]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[5003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:34 volumiojg1 sudo[5003]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:34 volumiojg1 sudo[5003]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[5007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:34 volumiojg1 sudo[5007]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:34 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:34 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:34 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:34 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:34 volumiojg1 sudo[5018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:34 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:34 volumiojg1 sudo[5018]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[5018]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[5022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:34 volumiojg1 sudo[5022]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[5022]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[5013]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:34 volumiojg1 sudo[5013]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:34 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:34 volumiojg1 sudo[5013]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:34 volumiojg1 sudo[5031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 sudo[5031]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 sudo[5031]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:34 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Shairport-Sync Started Dec 24 12:57:34 volumiojg1 sudo[5034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:34 volumiojg1 sudo[5034]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:34 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:34 volumiojg1 systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Dec 24 12:57:34 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:34 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:34 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:34 volumiojg1 sudo[5045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:34 volumiojg1 sudo[5045]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[5034]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Asound.conf file written Dec 24 12:57:34 volumiojg1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 24 12:57:34 volumiojg1 systemd[1]: shairport-sync.service: Succeeded. Dec 24 12:57:34 volumiojg1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:34 volumiojg1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:34 volumiojg1 sudo[5049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 24 12:57:34 volumiojg1 sudo[5049]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[5045]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 sudo[5049]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:34 volumiojg1 sudo[5058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:34 volumiojg1 sudo[5058]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:34 volumiojg1 sudo[5058]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:34 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:34 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:35 volumiojg1 sudo[5061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:35 volumiojg1 sudo[5061]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:35 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:35 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:35 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:35 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:35 volumiojg1 sudo[5070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:35 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:35 volumiojg1 sudo[5070]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 sudo[5073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:35 volumiojg1 sudo[5073]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 sudo[5073]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5070]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 sudo[5080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:35 volumiojg1 sudo[5080]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:35 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Shairport-Sync Started Dec 24 12:57:35 volumiojg1 sudo[5066]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:35 volumiojg1 sudo[5066]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:35 volumiojg1 sudo[5080]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5066]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:35 volumiojg1 sudo[5084]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.219 [5037.5037] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.223 [5037.5037] INFO VolumeManager: [0xf4bc50]: Setting new playback volume: 75 Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.223 [5037.5037] INFO VolumeManager: [0xf4bc50]: Setting new mute state: 0 Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.223 [5037.5037] INFO QobuzConnect: [0xf4c620]: Client initialized! Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.223 [5037.5037] INFO SampleApp: Starting Avahi advertising, name: VolumioJG1, service name: _qobuz-connect._tcp Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.237 [5037.5037] INFO LocalConfigManager: [0xf4b530]: Starting Local Configuration server Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.237 [5037.5037] INFO SampleApp: Starting Local configuration server Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.237 [5037.5037] INFO SampleApp: Connected to UNIX socket client 0xf40f60 Dec 24 12:57:35 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.268 [5037.5037] INFO SampleApp: Stopping Local configuration server Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 qobuz-connect[5037]: 20251224 12:57:35.278 [5037.5037] INFO SampleApp: shat down connection on UNIX socket Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:35 volumiojg1 sudo[5095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:35 volumiojg1 sudo[5095]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:35 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:35 volumiojg1 sudo[5084]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 systemd[1]: shairport-sync.service: Succeeded. Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:35 volumiojg1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:35 volumiojg1 sudo[5095]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.377 [5097.5097] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.384 [5097.5097] INFO VolumeManager: [0xc36c50]: Setting new playback volume: 75 Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.385 [5097.5097] INFO VolumeManager: [0xc36c50]: Setting new mute state: 0 Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.385 [5097.5097] INFO QobuzConnect: [0xc37620]: Client initialized! Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.385 [5097.5097] INFO SampleApp: Starting Avahi advertising, name: VolumioJG1, service name: _qobuz-connect._tcp Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Shairport-Sync Started Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.397 [5097.5097] INFO LocalConfigManager: [0xc36530]: Starting Local Configuration server Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.397 [5097.5097] INFO SampleApp: Starting Local configuration server Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.398 [5097.5097] INFO SampleApp: Connected to UNIX socket client 0xc2bf60 Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Enabling plugin fusiondsp Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Loading plugin "fusiondsp"... Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Applying required configuration parameters for plugin fusiondsp Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:35 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:35 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Asound.conf file unchanged, so no further update is needed Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:35 volumiojg1 sudo[5106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:35 volumiojg1 sudo[5106]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:35 volumiojg1 sudo[5106]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:35 volumiojg1 sudo[5109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:35 volumiojg1 sudo[5109]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.527 [5097.5097] INFO SampleApp: Playback volume changed: 75 Dec 24 12:57:35 volumiojg1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:35 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:35 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:35 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:35 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:35 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:35 volumiojg1 volumio[1115]: info: PLUGIN START: fusiondsp Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Loading i18n strings for locale en Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: FusionDsp - mixtype--------------------- Hardware Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:35 volumiojg1 sudo[5118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:35 volumiojg1 sudo[5118]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Done. Dec 24 12:57:35 volumiojg1 sudo[5118]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:35 volumiojg1 sudo[5122]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 sudo[5114]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:35 volumiojg1 sudo[5114]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 sudo[5114]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:35 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:35 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:35 volumiojg1 sudo[5122]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:35 volumiojg1 sudo[5130]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:35 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:35 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 sudo[5130]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 sudo[5134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:35 volumiojg1 sudo[5134]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:35 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.753 [5097.5097] INFO SampleApp: Stopping Local configuration server Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Asound.conf file unchanged, so no further update is needed Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:35 volumiojg1 qobuz-connect[5097]: 20251224 12:57:35.763 [5097.5097] INFO SampleApp: shat down connection on UNIX socket Dec 24 12:57:35 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:35 volumiojg1 sudo[5140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:35 volumiojg1 sudo[5140]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:35 volumiojg1 sudo[5144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:35 volumiojg1 sudo[5144]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:35 volumiojg1 sudo[5144]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:35 volumiojg1 sudo[5147]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 sudo[5134]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 24 12:57:35 volumiojg1 systemd[1]: shairport-sync.service: Succeeded. Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:35 volumiojg1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:35 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:35 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:35 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:35 volumiojg1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:35 volumiojg1 sudo[5140]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:35 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:35 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:35 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:35 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:35 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:35 volumiojg1 sudo[5153]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:35 volumiojg1 sudo[5153]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:35 volumiojg1 sudo[5153]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:35 volumiojg1 sudo[5161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:35 volumiojg1 sudo[5161]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:36 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:36 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Shairport-Sync Started Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:35 volumiojg1 sudo[5165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:35 volumiojg1 sudo[5165]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 sudo[5171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:36 volumiojg1 sudo[5171]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.078 [5143.5143] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.082 [5143.5143] INFO VolumeManager: [0xdcec50]: Setting new playback volume: 75 Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.082 [5143.5143] INFO VolumeManager: [0xdcec50]: Setting new mute state: 0 Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.082 [5143.5143] INFO QobuzConnect: [0xdcf620]: Client initialized! Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.082 [5143.5143] INFO SampleApp: Starting Avahi advertising, name: VolumioJG1, service name: _qobuz-connect._tcp Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.093 [5143.5143] INFO LocalConfigManager: [0xdce530]: Starting Local Configuration server Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.094 [5143.5143] INFO SampleApp: Starting Local configuration server Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.094 [5143.5143] INFO SampleApp: Connected to UNIX socket client 0xdc3f60 Dec 24 12:57:36 volumiojg1 sudo[5171]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 sudo[5161]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 sudo[5180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:36 volumiojg1 sudo[5180]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 sudo[5165]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.145 [5143.5143] INFO SampleApp: Stopping Local configuration server Dec 24 12:57:36 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:36 volumiojg1 qobuz-connect[5143]: 20251224 12:57:36.155 [5143.5143] INFO SampleApp: shat down connection on UNIX socket Dec 24 12:57:36 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:36 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:36 volumiojg1 volumio[1115]: info: camilladsp service started and running in background, instance 1 Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:36 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:36 volumiojg1 sudo[5180]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:36 volumiojg1 volumio[1115]: cannot open device 'volumioHw': Device or resource busy Dec 24 12:57:36 volumiojg1 volumio[1115]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 24 12:57:36 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:36 volumiojg1 volumio[1115]: cannot open device 'volumioHw': Device or resource busy Dec 24 12:57:36 volumiojg1 volumio[1115]: info: FusionDsp loaded Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 24 12:57:36 volumiojg1 sudo[5200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 24 12:57:36 volumiojg1 sudo[5200]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 volumio[1115]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Adding Signal Path Element [object Object] Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Adding fusiondspeq DSP Signal Path Element Dec 24 12:57:36 volumiojg1 volumio[1115]: info: FusionDsp - ---- installed callbackRead Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:36 volumiojg1 systemd[1]: Started FusionDsp Daemon. Dec 24 12:57:36 volumiojg1 volumio[1115]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 24 12:57:36 volumiojg1 sudo[5200]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:36 volumiojg1 sudo[5204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:36 volumiojg1 sudo[5204]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.410 [5187.5187] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 24 12:57:36 volumiojg1 systemd[1]: shairport-sync.service: Succeeded. Dec 24 12:57:36 volumiojg1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.419 [5187.5187] INFO VolumeManager: [0x1a71c50]: Setting new playback volume: 75 Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.419 [5187.5187] INFO VolumeManager: [0x1a71c50]: Setting new mute state: 0 Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.419 [5187.5187] INFO QobuzConnect: [0x1a72620]: Client initialized! Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.419 [5187.5187] INFO SampleApp: Starting Avahi advertising, name: VolumioJG1, service name: _qobuz-connect._tcp Dec 24 12:57:36 volumiojg1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:36 volumiojg1 sudo[5204]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.448 [5187.5187] INFO LocalConfigManager: [0x1a71530]: Starting Local Configuration server Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.449 [5187.5187] INFO SampleApp: Starting Local configuration server Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.449 [5187.5187] INFO SampleApp: Connected to UNIX socket client 0x1a66f60 Dec 24 12:57:36 volumiojg1 volumio[1115]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:36 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 24 12:57:36 volumiojg1 volumio[1115]: error: FusionDsp - WebSocket error: [object Object] Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Shairport-Sync Started Dec 24 12:57:36 volumiojg1 volumio[1115]: (node:1115) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 24 12:57:36 volumiojg1 volumio[1115]: (Use `node --trace-warnings ...` to show where the warning was created) Dec 24 12:57:36 volumiojg1 volumio[1115]: (node:1115) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 24 12:57:36 volumiojg1 volumio[1115]: (node:1115) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 24 12:57:36 volumiojg1 volumio[1115]: (node:1115) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 24 12:57:36 volumiojg1 volumio[1115]: (node:1115) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 24 12:57:36 volumiojg1 qobuz-connect[5187]: 20251224 12:57:36.560 [5187.5187] INFO SampleApp: Playback volume changed: 75 Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Enabling plugin fusiondsp Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Loading plugin "fusiondsp"... Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Applying required configuration parameters for plugin fusiondsp Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:36 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:36 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Asound.conf file unchanged, so no further update is needed Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:36 volumiojg1 sudo[5213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:36 volumiojg1 sudo[5213]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:36 volumiojg1 sudo[5213]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:36 volumiojg1 sudo[5216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:36 volumiojg1 sudo[5216]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:36 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:36 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:36 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:36 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:36 volumiojg1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:36 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:36 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:36 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:36 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:37 volumiojg1 volumio[1115]: info: PLUGIN START: fusiondsp Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Loading i18n strings for locale en Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: FusionDsp - mixtype--------------------- Hardware Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Preparing to generate the ALSA configuration file Dec 24 12:57:37 volumiojg1 sudo[5225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:37 volumiojg1 sudo[5225]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Done. Dec 24 12:57:37 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:37 volumiojg1 sudo[5228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:37 volumiojg1 sudo[5228]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 sudo[5225]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 sudo[5228]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 volumio[1115]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 24 12:57:37 volumiojg1 volumio[1115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Reading ALSA contributions from plugins. Dec 24 12:57:37 volumiojg1 sudo[5221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:37 volumiojg1 sudo[5221]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 sudo[5235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:37 volumiojg1 sudo[5235]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 go-librespot[1292]: time="2025-12-24T12:57:37-06:00" level=debug msg="fetched chunk 21/29, size: 524288" uri="spotify:track:3ONFcrwlLYLUZBPh0WSD6q" Dec 24 12:57:37 volumiojg1 sudo[5221]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:37 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:37 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:37 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:37 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:37 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:37 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:37 volumiojg1 sudo[5235]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 sudo[5245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:37 volumiojg1 sudo[5245]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 qobuz-connect[5187]: 20251224 12:57:37.364 [5187.5187] INFO SampleApp: Stopping Local configuration server Dec 24 12:57:37 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:37 volumiojg1 volumio[1115]: 0+0 records in Dec 24 12:57:37 volumiojg1 volumio[1115]: 0+0 records out Dec 24 12:57:37 volumiojg1 volumio[1115]: 0 bytes copied, 0.000747639 s, 0.0 kB/s Dec 24 12:57:37 volumiojg1 qobuz-connect[5187]: 20251224 12:57:37.375 [5187.5187] INFO SampleApp: shat down connection on UNIX socket Dec 24 12:57:37 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:37 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:37 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:37 volumiojg1 sudo[5245]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:37 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:37 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 24 12:57:37 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:37 volumiojg1 sudo[5268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:37 volumiojg1 sudo[5268]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 24 12:57:37 volumiojg1 systemd[1]: shairport-sync.service: Succeeded. Dec 24 12:57:37 volumiojg1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:37 volumiojg1 systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 24 12:57:37 volumiojg1 systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:37 volumiojg1 systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:37 volumiojg1 sudo[5268]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.634 [5253.5253] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.638 [5253.5253] INFO VolumeManager: [0x1b7ec50]: Setting new playback volume: 75 Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.639 [5253.5253] INFO VolumeManager: [0x1b7ec50]: Setting new mute state: 0 Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.639 [5253.5253] INFO QobuzConnect: [0x1b7f620]: Client initialized! Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.639 [5253.5253] INFO SampleApp: Starting Avahi advertising, name: VolumioJG1, service name: _qobuz-connect._tcp Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.652 [5253.5253] INFO LocalConfigManager: [0x1b7e530]: Starting Local Configuration server Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.652 [5253.5253] INFO SampleApp: Starting Local configuration server Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.652 [5253.5253] INFO SampleApp: Connected to UNIX socket client 0x1b73f60 Dec 24 12:57:37 volumiojg1 volumio[1115]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 24 12:57:37 volumiojg1 volumio[1115]: 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 Dec 24 12:57:37 volumiojg1 volumio[1115]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 24 12:57:37 volumiojg1 volumio[1115]: info: camilladsp service started and running in background, instance 2 Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:37 volumiojg1 volumio[1115]: cannot open device 'volumioHw': Device or resource busy Dec 24 12:57:37 volumiojg1 volumio[1115]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 24 12:57:37 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:37 volumiojg1 volumio[1115]: cannot open device 'volumioHw': Device or resource busy Dec 24 12:57:37 volumiojg1 volumio[1115]: info: FusionDsp loaded Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 24 12:57:37 volumiojg1 volumio[1115]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Adding Signal Path Element [object Object] Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Updating fusiondspeq DSP Signal Path Element Dec 24 12:57:37 volumiojg1 volumio[1115]: info: FusionDsp - ---- installed callbackRead Dec 24 12:57:37 volumiojg1 volumio[1115]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Asound.conf file unchanged, so no further update is needed Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Output device has changed, restarting MPD Dec 24 12:57:37 volumiojg1 sudo[5296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 24 12:57:37 volumiojg1 sudo[5296]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 qobuz-connect[5253]: 20251224 12:57:37.785 [5253.5253] INFO SampleApp: Playback volume changed: 75 Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Output device has changed, restarting Shairport Sync Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:37 volumiojg1 sudo[5299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 24 12:57:37 volumiojg1 sudo[5299]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 sudo[5296]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 sudo[5299]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 sudo[5301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 24 12:57:37 volumiojg1 sudo[5301]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:37 volumiojg1 systemd[1]: mpd.service: Succeeded. Dec 24 12:57:37 volumiojg1 systemd[1]: Stopped Music Player Daemon. Dec 24 12:57:37 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:37 volumiojg1 volumio[1115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 24 12:57:37 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:37 volumiojg1 volumio[1115]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:37 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:37 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:37 volumiojg1 systemd[1]: Starting Music Player Daemon... Dec 24 12:57:37 volumiojg1 sudo[5311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:37 volumiojg1 sudo[5311]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 sudo[5314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 24 12:57:37 volumiojg1 sudo[5314]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:37 volumiojg1 sudo[5311]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:37 volumiojg1 sudo[5307]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 24 12:57:37 volumiojg1 sudo[5307]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 sudo[5307]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5314]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:38 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 24 12:57:38 volumiojg1 volumio[1115]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 24 12:57:38 volumiojg1 volumio[1115]: info: FusionDsp - ---- read samplerate, raw: Dec 24 12:57:38 volumiojg1 volumio[1115]: error: FusionDsp - invalid sample rate Dec 24 12:57:38 volumiojg1 volumio[1115]: info: FusionDsp - ---- read samplerate, raw: Dec 24 12:57:38 volumiojg1 volumio[1115]: error: FusionDsp - invalid sample rate Dec 24 12:57:38 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:38 volumiojg1 sudo[5324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 24 12:57:38 volumiojg1 sudo[5324]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 sudo[5324]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 24 12:57:38 volumiojg1 volumio[1115]: Job for shairport-sync.service failed. Dec 24 12:57:38 volumiojg1 volumio[1115]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Dec 24 12:57:38 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:38 volumiojg1 sudo[5328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 24 12:57:38 volumiojg1 sudo[5328]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 qobuz-connect[5253]: 20251224 12:57:38.105 [5253.5253] INFO SampleApp: Stopping Local configuration server Dec 24 12:57:38 volumiojg1 systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 24 12:57:38 volumiojg1 qobuz-connect[5253]: 20251224 12:57:38.115 [5253.5253] INFO SampleApp: shat down connection on UNIX socket Dec 24 12:57:38 volumiojg1 systemd[1]: qobuz-connect.service: Succeeded. Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 24 12:57:38 volumiojg1 volumio[1115]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 24 12:57:38 volumiojg1 volumio[1115]: info: MPD Permissions set Dec 24 12:57:38 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:38 volumiojg1 systemd[1]: Started Volumio Qobuz Connect Service. Dec 24 12:57:38 volumiojg1 sudo[5353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:38 volumiojg1 sudo[5328]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5353]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 24 12:57:38 volumiojg1 volumio[1115]: info: QobuzConnect: setDeactiveState invoked Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 systemd[1]: Started Volumio Tidal Connect Service. Dec 24 12:57:38 volumiojg1 sudo[5353]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 volumio[1115]: error: FusionDsp - WebSocket error: [object Object] Dec 24 12:57:38 volumiojg1 volumio[1115]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Executing endpoint qc_getconfig Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.366 [5347.5347] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.371 [5347.5347] INFO VolumeManager: [0x1bf1c50]: Setting new playback volume: 75 Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.372 [5347.5347] INFO VolumeManager: [0x1bf1c50]: Setting new mute state: 0 Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.372 [5347.5347] INFO QobuzConnect: [0x1bf2620]: Client initialized! Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.372 [5347.5347] INFO SampleApp: Starting Avahi advertising, name: VolumioJG1, service name: _qobuz-connect._tcp Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.387 [5347.5347] INFO LocalConfigManager: [0x1bf1530]: Starting Local Configuration server Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.387 [5347.5347] INFO SampleApp: Starting Local configuration server Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.388 [5347.5347] INFO SampleApp: Connected to UNIX socket client 0x1be6f60 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 24 12:57:38 volumiojg1 volumio[1115]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Starting Shairport Sync Dec 24 12:57:38 volumiojg1 sudo[5397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:38 volumiojg1 sudo[5397]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 qobuz-connect[5347]: 20251224 12:57:38.516 [5347.5347] INFO SampleApp: Playback volume changed: 75 Dec 24 12:57:38 volumiojg1 sudo[5397]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 24 12:57:38 volumiojg1 sudo[5400]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Executing endpoint tc_getconfig Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 24 12:57:38 volumiojg1 vtcs[5357]: STARTING TidalConnect services, version: 1.5.2.56 Dec 24 12:57:38 volumiojg1 systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 24 12:57:38 volumiojg1 systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 24 12:57:38 volumiojg1 systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Dec 24 12:57:38 volumiojg1 vtcs[5357]: STARTED TidalConnect services. Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 sudo[5400]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:38 volumiojg1 sudo[5418]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 24 12:57:38 volumiojg1 volumio[1115]: Job for shairport-sync.service failed. Dec 24 12:57:38 volumiojg1 volumio[1115]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Executing endpoint tc_connect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Connecting to TidalConnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:38 volumiojg1 sudo[5418]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::servicePushState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreStateMachine::pushState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioPushState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: MRS: Pushing multiroomSync output update for this device Dec 24 12:57:38 volumiojg1 volumio[1115]: info: MRS: Pushing multiroomSync output Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::servicePushState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreStateMachine::pushState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioPushState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: MRS: Pushing multiroomSync output update for this device Dec 24 12:57:38 volumiojg1 volumio[1115]: info: MRS: Pushing multiroomSync output Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CoreCommandRouter::volumioGetState Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: CorePlayQueue::getTrack 26 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:38 volumiojg1 volumio[1115]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Dec 24 12:57:38 volumiojg1 volumio[1115]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:38 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:38 volumiojg1 mpd[5322]: Dec 24 12:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 24 12:57:38 volumiojg1 systemd[1]: Started Music Player Daemon. Dec 24 12:57:38 volumiojg1 sudo[5007]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[4966]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5109]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5301]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5061]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5147]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5216]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:38 volumiojg1 sudo[5476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:38 volumiojg1 sudo[5476]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:38 volumiojg1 sudo[5476]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:39 volumiojg1 volumio[1115]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 24 12:57:39 volumiojg1 volumio[1115]: 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 Dec 24 12:57:39 volumiojg1 volumio[1115]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 24 12:57:39 volumiojg1 volumio[1115]: info: camilladsp service started and running in background, instance 3 Dec 24 12:57:39 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 24 12:57:39 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:39 volumiojg1 volumio[1115]: cannot open device 'volumioHw': Device or resource busy Dec 24 12:57:39 volumiojg1 volumio[1115]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 24 12:57:39 volumiojg1 volumio[1115]: xcb_connection_has_error() returned true Dec 24 12:57:39 volumiojg1 volumio[1115]: cannot open device 'volumioHw': Device or resource busy Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp loaded Dec 24 12:57:39 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 24 12:57:39 volumiojg1 volumio[1115]: info: Adding Signal Path Element [object Object] Dec 24 12:57:39 volumiojg1 volumio[1115]: info: Updating fusiondspeq DSP Signal Path Element Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp - ---- installed callbackRead Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 24 12:57:39 volumiojg1 sudo[5509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 24 12:57:39 volumiojg1 sudo[5509]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: MPD error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: MPD error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: MPD error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: MPD error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: MPD error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: MPD error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: error: The expression evaluated to a falsy value: Dec 24 12:57:39 volumiojg1 volumio[1115]: assert.ok(self.idling) Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp - ---- read samplerate, raw: Dec 24 12:57:39 volumiojg1 volumio[1115]: error: FusionDsp - invalid sample rate Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp - ---- read samplerate, raw: Dec 24 12:57:39 volumiojg1 volumio[1115]: error: FusionDsp - invalid sample rate Dec 24 12:57:39 volumiojg1 volumio[1115]: info: FusionDsp - ---- read samplerate, raw: Dec 24 12:57:39 volumiojg1 volumio[1115]: error: FusionDsp - invalid sample rate Dec 24 12:57:39 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:39 volumiojg1 sudo[5509]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:39 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:39 volumiojg1 volumio[1115]: error: updateQueue error: null Dec 24 12:57:39 volumiojg1 volumio[1115]: error: FusionDsp - WebSocket error: [object Object] Dec 24 12:57:39 volumiojg1 volumio[1115]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 24 12:57:39 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:39 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:39 volumiojg1 sudo[5562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:39 volumiojg1 sudo[5562]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:39 volumiojg1 sudo[5562]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:40 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:40 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:40 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:40 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:40 volumiojg1 sudo[5847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:40 volumiojg1 sudo[5847]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:40 volumiojg1 sudo[5847]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:41 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:41 volumiojg1 volumio[1115]: info: TidalConnect service stoped! Dec 24 12:57:41 volumiojg1 volumio[1115]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:41 volumiojg1 volumio[1115]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 24 12:57:41 volumiojg1 sudo[6118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 24 12:57:41 volumiojg1 sudo[6118]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:41 volumiojg1 sudo[6118]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:41 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:41 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:41 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:42 volumiojg1 sudo[6367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 sudo[6367]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:42 volumiojg1 sudo[6370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 sudo[6370]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 systemd[1]: Stopping MPD Monitor Service... Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Succeeded. Dec 24 12:57:42 volumiojg1 systemd[1]: Stopped MPD Monitor Service. Dec 24 12:57:42 volumiojg1 systemd[1]: Started MPD Monitor Service. Dec 24 12:57:42 volumiojg1 sudo[6388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 mpd_monitor.sh[6373]: MPD Monitor Service: Starting MPD Monitor Service Dec 24 12:57:42 volumiojg1 sudo[6388]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 sudo[6367]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 sudo[6390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 sudo[6390]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 systemd[1]: Stopping MPD Monitor Service... Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Succeeded. Dec 24 12:57:42 volumiojg1 systemd[1]: Stopped MPD Monitor Service. Dec 24 12:57:42 volumiojg1 systemd[1]: Started MPD Monitor Service. Dec 24 12:57:42 volumiojg1 sudo[6370]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 systemd[1]: Stopping MPD Monitor Service... Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Succeeded. Dec 24 12:57:42 volumiojg1 systemd[1]: Stopped MPD Monitor Service. Dec 24 12:57:42 volumiojg1 sudo[6388]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 sudo[6397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 sudo[6397]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 systemd[1]: Started MPD Monitor Service. Dec 24 12:57:42 volumiojg1 sudo[6390]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 mpd_monitor.sh[6402]: MPD Monitor Service: Starting MPD Monitor Service Dec 24 12:57:42 volumiojg1 systemd[1]: Stopping MPD Monitor Service... Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Succeeded. Dec 24 12:57:42 volumiojg1 systemd[1]: Stopped MPD Monitor Service. Dec 24 12:57:42 volumiojg1 systemd[1]: Started MPD Monitor Service. Dec 24 12:57:42 volumiojg1 sudo[6403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 sudo[6403]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 sudo[6397]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:42 volumiojg1 mpd_monitor.sh[6406]: MPD Monitor Service: Starting MPD Monitor Service Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 sudo[6408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 systemd[1]: Stopping MPD Monitor Service... Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:42 volumiojg1 sudo[6408]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Succeeded. Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 systemd[1]: Stopped MPD Monitor Service. Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 systemd[1]: Started MPD Monitor Service. Dec 24 12:57:42 volumiojg1 volumio[1115]: info: Successfully started MPD Monitor Dec 24 12:57:42 volumiojg1 sudo[6403]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 mpd_monitor.sh[6413]: MPD Monitor Service: Starting MPD Monitor Service Dec 24 12:57:42 volumiojg1 volumio[1115]: info: Successfully started MPD Monitor Dec 24 12:57:42 volumiojg1 volumio[1115]: info: Successfully started MPD Monitor Dec 24 12:57:42 volumiojg1 volumio[1115]: info: Successfully started MPD Monitor Dec 24 12:57:42 volumiojg1 systemd[1]: Stopping MPD Monitor Service... Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Succeeded. Dec 24 12:57:42 volumiojg1 systemd[1]: Stopped MPD Monitor Service. Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Start request repeated too quickly. Dec 24 12:57:42 volumiojg1 systemd[1]: mpd_monitor.service: Failed with result 'start-limit-hit'. Dec 24 12:57:42 volumiojg1 systemd[1]: Failed to start MPD Monitor Service. Dec 24 12:57:42 volumiojg1 sudo[6408]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:42 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 24 12:57:42 volumiojg1 volumio[1115]: error: Cannot restart MPD Monitor: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd_monitor.service Dec 24 12:57:42 volumiojg1 volumio[1115]: Job for mpd_monitor.service failed. Dec 24 12:57:42 volumiojg1 volumio[1115]: See "systemctl status mpd_monitor.service" and "journalctl -xe" for details. Dec 24 12:57:42 volumiojg1 volumio[1115]: info: Successfully started MPD Monitor Dec 24 12:57:42 volumiojg1 volumio[1115]: info: Successfully started MPD Monitor Dec 24 12:57:42 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:43 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:44 volumiojg1 volumio[1115]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 24 12:57:44 volumiojg1 volumio[1115]: info: TidalConnect service started! Dec 24 12:57:46 volumiojg1 volumio[1115]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 24 12:57:46 volumiojg1 volumio[1115]: info: FusionDsp - Stopping FusionDsp service Dec 24 12:57:46 volumiojg1 volumio[1115]: info: camilladsp stopping service pid 7615... Dec 24 12:57:46 volumiojg1 volumio[1115]: info: camilladsp service terminated, instance 3 Dec 24 12:57:46 volumiojg1 sudo[7632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Dec 24 12:57:46 volumiojg1 sudo[7632]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 24 12:57:46 volumiojg1 systemd[1]: Stopping FusionDsp Daemon... Dec 24 12:57:46 volumiojg1 volumio[5202]: Backend configuration: Dec 24 12:57:46 volumiojg1 volumio[5202]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Dec 24 12:57:46 volumiojg1 volumio[5202]: active_config_txt: null Dec 24 12:57:46 volumiojg1 volumio[5202]: camilla_host: 127.0.0.1 Dec 24 12:57:46 volumiojg1 volumio[5202]: camilla_port: 9876 Dec 24 12:57:46 volumiojg1 volumio[5202]: coeff_dir: /data/INTERNAL/FusionDsp/filters Dec 24 12:57:46 volumiojg1 volumio[5202]: config_dir: /data/configuration/audio_interface/fusiondsp Dec 24 12:57:46 volumiojg1 volumio[5202]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Dec 24 12:57:46 volumiojg1 volumio[5202]: log_file: /tmp/camilladsp.log Dec 24 12:57:46 volumiojg1 volumio[5202]: on_get_active_config: null Dec 24 12:57:46 volumiojg1 volumio[5202]: on_set_active_config: null Dec 24 12:57:46 volumiojg1 volumio[5202]: port: 5011 Dec 24 12:57:46 volumiojg1 volumio[5202]: supported_capture_types: null Dec 24 12:57:46 volumiojg1 volumio[5202]: supported_playback_types: null Dec 24 12:57:46 volumiojg1 volumio[5202]: update_config_symlink: false Dec 24 12:57:46 volumiojg1 volumio[5202]: update_config_txt: false Dec 24 12:57:46 volumiojg1 volumio[5202]: ======== Running on http://0.0.0.0:5011 ======== Dec 24 12:57:46 volumiojg1 volumio[5202]: (Press CTRL+C to quit) Dec 24 12:57:46 volumiojg1 volumio[1115]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 24 12:57:46 volumiojg1 systemd[1]: fusiondsp.service: Succeeded. Dec 24 12:57:46 volumiojg1 systemd[1]: Stopped FusionDsp Daemon. Dec 24 12:57:46 volumiojg1 sudo[7632]: pam_unix(sudo:session): session closed for user root Dec 24 12:57:46 volumiojg1 volumio[1115]: info: FusionDsp - Reporting Fusion DSP Disabled Dec 24 12:57:46 volumiojg1 volumio[1115]: info: Removing fusiondspeq DSP Signal Path Element Dec 24 12:57:46 volumiojg1 volumio[1115]: info: Check plugin dependencies Dec 24 12:57:46 volumiojg1 volumio[1115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 24 12:57:46 volumiojg1 volumio[1115]: info: Rename folder Dec 24 12:57:46 volumiojg1 volumio[1115]: info: Folder /tmp/downloaded_plugin.zip removed Dec 24 12:57:46 volumiojg1 volumio[1115]: info: Move to category Dec 24 12:57:46 volumiojg1 volumio[1115]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 24 12:57:46 volumiojg1 volumio[1115]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Dec 24 12:57:46 volumiojg1 volumio[1115]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Dec 24 12:57:46 volumiojg1 volumio[1115]: at onErrorNT (internal/child_process.js:465:16) Dec 24 12:57:46 volumiojg1 volumio[1115]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Dec 24 12:57:46 volumiojg1 volumio[1115]: errno: -2, Dec 24 12:57:46 volumiojg1 volumio[1115]: code: 'ENOENT', Dec 24 12:57:46 volumiojg1 volumio[1115]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Dec 24 12:57:46 volumiojg1 volumio[1115]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Dec 24 12:57:46 volumiojg1 volumio[1115]: spawnargs: [ Dec 24 12:57:46 volumiojg1 volumio[1115]: '-p', Dec 24 12:57:46 volumiojg1 volumio[1115]: 9876, Dec 24 12:57:46 volumiojg1 volumio[1115]: '-o', Dec 24 12:57:46 volumiojg1 volumio[1115]: '/tmp/camilladsp.log', Dec 24 12:57:46 volumiojg1 volumio[1115]: '-l', Dec 24 12:57:46 volumiojg1 volumio[1115]: 'warn', Dec 24 12:57:46 volumiojg1 volumio[1115]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Dec 24 12:57:46 volumiojg1 volumio[1115]: ] Dec 24 12:57:46 volumiojg1 volumio[1115]: } Dec 24 12:57:46 volumiojg1 volumio[1115]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 24 12:57:47 volumiojg1 sudo[7769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-24 12:56 Dec 24 12:57:47 volumiojg1 sudo[7769]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"