-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2025-09-12 18:08:10 CEST. -- Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3-dbus. Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../39-python3-dbus_1.2.8-3_armhf.deb ... Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3-dbus. Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../39-python3-dbus_1.2.8-3_armhf.deb ... Sep 12 18:07:00 volumio volumio[955]: info: Unpacking python3-dbus (1.2.8-3) ... Sep 12 18:07:00 volumio volumio[955]: info: Unpacking python3-dbus (1.2.8-3) ... Sep 12 18:07:00 volumio volumio[955]: verbose: New Socket.io Connection to volumio.local from 10.0.0.236 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 12 18:07:00 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:00 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:00 volumio volumio[955]: info: CoreCommandRouter::volumioGetQueue Sep 12 18:07:00 volumio volumio[955]: info: CoreStateMachine::getQueue Sep 12 18:07:00 volumio volumio[955]: info: CorePlayQueue::getQueue Sep 12 18:07:00 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Sep 12 18:07:00 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Sep 12 18:07:00 volumio volumio[955]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Sep 12 18:07:00 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Sep 12 18:07:00 volumio volumio[955]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Sep 12 18:07:00 volumio volumio[955]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Sep 12 18:07:00 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3.7-dev. Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3.7-dev. Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Sep 12 18:07:00 volumio volumio[955]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Sep 12 18:07:00 volumio volumio[955]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3-dev. Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3-dev. Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Sep 12 18:07:00 volumio volumio[955]: info: Unpacking python3-dev (3.7.3-1) ... Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Sep 12 18:07:00 volumio volumio[955]: info: Unpacking python3-dev (3.7.3-1) ... Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3-entrypoints. Sep 12 18:07:00 volumio volumio[955]: info: Selecting previously unselected package python3-entrypoints. Sep 12 18:07:00 volumio volumio[955]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-entrypoints (0.3-1) ... Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-entrypoints (0.3-1) ... Sep 12 18:07:01 volumio volumio[955]: info: Selecting previously unselected package python3-gi. Sep 12 18:07:01 volumio volumio[955]: info: Selecting previously unselected package python3-gi. Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-gi (3.30.4-1) ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-gi (3.30.4-1) ... Sep 12 18:07:01 volumio volumio[955]: info: Selecting previously unselected package python3-secretstorage. Sep 12 18:07:01 volumio volumio[955]: info: Selecting previously unselected package python3-secretstorage. Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../44-python3-secretstorage_2.3.1-2_all.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-secretstorage (2.3.1-2) ... Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../44-python3-secretstorage_2.3.1-2_all.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-secretstorage (2.3.1-2) ... Sep 12 18:07:01 volumio volumio[955]: info: Selecting previously unselected package python3-keyring. Sep 12 18:07:01 volumio volumio[955]: info: Selecting previously unselected package python3-keyring. Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../45-python3-keyring_17.1.1-1_all.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-keyring (17.1.1-1) ... Sep 12 18:07:01 volumio volumio[955]: info: Preparing to unpack .../45-python3-keyring_17.1.1-1_all.deb ... Sep 12 18:07:01 volumio volumio[955]: info: Unpacking python3-keyring (17.1.1-1) ... Sep 12 18:07:02 volumio volumio[955]: info: Selecting previously unselected package python3-keyrings.alt. Sep 12 18:07:02 volumio volumio[955]: info: Selecting previously unselected package python3-keyrings.alt. Sep 12 18:07:02 volumio volumio[955]: info: Preparing to unpack .../46-python3-keyrings.alt_3.1.1-1_all.deb ... Sep 12 18:07:02 volumio volumio[955]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Sep 12 18:07:02 volumio volumio[955]: info: Preparing to unpack .../46-python3-keyrings.alt_3.1.1-1_all.deb ... Sep 12 18:07:02 volumio volumio[955]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Sep 12 18:07:02 volumio volumio[955]: info: Selecting previously unselected package python3-pip. Sep 12 18:07:02 volumio volumio[955]: info: Selecting previously unselected package python3-pip. Sep 12 18:07:02 volumio volumio[955]: info: Preparing to unpack .../47-python3-pip_18.1-5+rpt1_all.deb ... Sep 12 18:07:02 volumio volumio[955]: info: Unpacking python3-pip (18.1-5+rpt1) ... Sep 12 18:07:02 volumio volumio[955]: info: Preparing to unpack .../47-python3-pip_18.1-5+rpt1_all.deb ... Sep 12 18:07:02 volumio volumio[955]: info: Unpacking python3-pip (18.1-5+rpt1) ... Sep 12 18:07:02 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:02 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:02 volumio volumio[955]: info: Listing playlists Sep 12 18:07:02 volumio volumio[955]: info: Listing playlists Sep 12 18:07:03 volumio volumio[955]: info: Selecting previously unselected package python3-setuptools. Sep 12 18:07:03 volumio volumio[955]: info: Preparing to unpack .../48-python3-setuptools_40.8.0-1_all.deb ... Sep 12 18:07:03 volumio volumio[955]: info: Selecting previously unselected package python3-setuptools. Sep 12 18:07:03 volumio volumio[955]: info: Preparing to unpack .../48-python3-setuptools_40.8.0-1_all.deb ... Sep 12 18:07:03 volumio volumio[955]: info: Unpacking python3-setuptools (40.8.0-1) ... Sep 12 18:07:03 volumio volumio[955]: info: Unpacking python3-setuptools (40.8.0-1) ... Sep 12 18:07:03 volumio volumio[955]: info: Selecting previously unselected package python3-wheel. Sep 12 18:07:03 volumio volumio[955]: info: Selecting previously unselected package python3-wheel. Sep 12 18:07:03 volumio volumio[955]: info: Preparing to unpack .../49-python3-wheel_0.32.3-2_all.deb ... Sep 12 18:07:03 volumio volumio[955]: info: Unpacking python3-wheel (0.32.3-2) ... Sep 12 18:07:03 volumio volumio[955]: info: Preparing to unpack .../49-python3-wheel_0.32.3-2_all.deb ... Sep 12 18:07:03 volumio volumio[955]: info: Unpacking python3-wheel (0.32.3-2) ... Sep 12 18:07:04 volumio volumio[955]: info: Selecting previously unselected package python3-xdg. Sep 12 18:07:04 volumio volumio[955]: info: Selecting previously unselected package python3-xdg. Sep 12 18:07:04 volumio volumio[955]: info: Preparing to unpack .../50-python3-xdg_0.25-5_all.deb ... Sep 12 18:07:04 volumio volumio[955]: info: Unpacking python3-xdg (0.25-5) ... Sep 12 18:07:04 volumio volumio[955]: info: Preparing to unpack .../50-python3-xdg_0.25-5_all.deb ... Sep 12 18:07:04 volumio volumio[955]: info: Unpacking python3-xdg (0.25-5) ... Sep 12 18:07:04 volumio volumio[955]: info: Setting up python3-entrypoints (0.3-1) ... Sep 12 18:07:04 volumio volumio[955]: info: Setting up python3-entrypoints (0.3-1) ... Sep 12 18:07:05 volumio volumio[955]: info: Setting up dh-python (3.20190308) ... Sep 12 18:07:05 volumio volumio[955]: info: Setting up dh-python (3.20190308) ... Sep 12 18:07:05 volumio volumio[955]: info: Setting up python3-attr (18.2.0-1) ... Sep 12 18:07:05 volumio volumio[955]: info: Setting up python3-attr (18.2.0-1) ... Sep 12 18:07:06 volumio volumio[955]: info: Setting up python3-dbus (1.2.8-3) ... Sep 12 18:07:06 volumio volumio[955]: info: Setting up python3-dbus (1.2.8-3) ... Sep 12 18:07:06 volumio volumio[955]: info: Setting up python3-setuptools (40.8.0-1) ... Sep 12 18:07:06 volumio volumio[955]: info: Setting up python3-setuptools (40.8.0-1) ... Sep 12 18:07:06 volumio volumio[955]: info: CALLMETHOD: system_controller system enableSSH true Sep 12 18:07:06 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , enableSSH Sep 12 18:07:06 volumio sudo[4676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh.service Sep 12 18:07:06 volumio sudo[4676]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:06 volumio sudo[4676]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:06 volumio sudo[4678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable ssh.service Sep 12 18:07:06 volumio sudo[4678]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:07 volumio systemd[1]: Reloading. Sep 12 18:07:07 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 12 18:07:07 volumio volumio[955]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Sep 12 18:07:07 volumio volumio[955]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Sep 12 18:07:07 volumio volumio[955]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Sep 12 18:07:07 volumio volumio[955]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Sep 12 18:07:07 volumio volumio[955]: info: Setting up python3-xdg (0.25-5) ... Sep 12 18:07:07 volumio volumio[955]: info: Setting up python3-xdg (0.25-5) ... Sep 12 18:07:07 volumio systemd[1]: Reloading. Sep 12 18:07:08 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 12 18:07:08 volumio volumio[955]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Sep 12 18:07:08 volumio volumio[955]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Sep 12 18:07:08 volumio volumio[955]: info: Setting up python3-wheel (0.32.3-2) ... Sep 12 18:07:08 volumio volumio[955]: info: Setting up python3-wheel (0.32.3-2) ... Sep 12 18:07:08 volumio systemd[1]: Reloading. Sep 12 18:07:08 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 12 18:07:09 volumio volumio[955]: info: Setting up python3-multidict (4.5.2-1) ... Sep 12 18:07:09 volumio volumio[955]: info: Setting up python3-multidict (4.5.2-1) ... Sep 12 18:07:09 volumio sudo[4678]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:09 volumio volumio[955]: info: enable SSH service success Sep 12 18:07:09 volumio volumio[955]: info: Setting up libfakeroot:armhf (1.23-1) ... Sep 12 18:07:09 volumio volumio[955]: info: Setting up libfakeroot:armhf (1.23-1) ... Sep 12 18:07:09 volumio volumio[955]: info: Setting up python3-async-timeout (3.0.1-1) ... Sep 12 18:07:09 volumio volumio[955]: info: Setting up python3-async-timeout (3.0.1-1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up fakeroot (1.23-1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up fakeroot (1.23-1) ... Sep 12 18:07:10 volumio volumio[955]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Sep 12 18:07:10 volumio volumio[955]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: 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 Sep 12 18:07:10 volumio volumio[955]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up make (4.2.1-1.2) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up make (4.2.1-1.2) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up python3-gi (3.30.4-1) ... Sep 12 18:07:10 volumio volumio[955]: info: Setting up python3-gi (3.30.4-1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up libmpc3:armhf (1.1.0-1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up libmpc3:armhf (1.1.0-1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up patch (2.7.6-3+deb10u1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up patch (2.7.6-3+deb10u1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up libisl19:armhf (0.20-2) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up libisl19:armhf (0.20-2) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up python3-crypto (2.6.1-9+b1) ... Sep 12 18:07:11 volumio volumio[955]: info: Setting up python3-crypto (2.6.1-9+b1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up python3-yarl (1.3.0-1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up python3-yarl (1.3.0-1) ... Sep 12 18:07:12 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:12 volumio volumio[955]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up python3-asn1crypto (0.24.0-1) ... Sep 12 18:07:12 volumio volumio[955]: info: Setting up python3-asn1crypto (0.24.0-1) ... Sep 12 18:07:13 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , setUpdaterChannel Sep 12 18:07:13 volumio volumio[955]: info: Updater channel set to test Sep 12 18:07:13 volumio volumio[955]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up python3-cffi-backend (1.12.2-1) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up python3-cffi-backend (1.12.2-1) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Sep 12 18:07:13 volumio volumio[955]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Sep 12 18:07:14 volumio volumio[955]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Sep 12 18:07:14 volumio volumio[955]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Sep 12 18:07:14 volumio volumio[955]: info: Setting up dpkg-dev (1.19.8) ... Sep 12 18:07:14 volumio volumio[955]: info: Setting up dpkg-dev (1.19.8) ... Sep 12 18:07:14 volumio volumio[955]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Sep 12 18:07:14 volumio volumio[955]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Sep 12 18:07:15 volumio volumio[955]: info: Setting up python3-pip (18.1-5+rpt1) ... Sep 12 18:07:15 volumio volumio[955]: info: Setting up python3-pip (18.1-5+rpt1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Sep 12 18:07:16 volumio volumio[955]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up python3-secretstorage (2.3.1-2) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up python3-secretstorage (2.3.1-2) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up python3-dev (3.7.3-1) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up python3-dev (3.7.3-1) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up python3-keyring (17.1.1-1) ... Sep 12 18:07:17 volumio volumio[955]: info: Setting up python3-keyring (17.1.1-1) ... Sep 12 18:07:18 volumio volumio[955]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Sep 12 18:07:18 volumio volumio[955]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Sep 12 18:07:18 volumio volumio[955]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Sep 12 18:07:18 volumio volumio[955]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Sep 12 18:07:18 volumio volumio[955]: info: Setting up build-essential (12.6) ... Sep 12 18:07:18 volumio volumio[955]: info: Setting up build-essential (12.6) ... Sep 12 18:07:18 volumio volumio[955]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Sep 12 18:07:18 volumio volumio[955]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Sep 12 18:07:19 volumio sudo[3944]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:19 volumio sudo[5004]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Sep 12 18:07:19 volumio sudo[5004]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:19 volumio volumio[955]: info: lib/systemd/system/fusiondsp.service Sep 12 18:07:19 volumio sudo[5004]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:19 volumio volumio[955]: info: lib/systemd/system/fusiondsp.service Sep 12 18:07:22 volumio volumio[955]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Sep 12 18:07:22 volumio volumio[955]: info: more info at http://www.winimage.com/zLibDll/unzip.html Sep 12 18:07:22 volumio volumio[955]: info: Sep 12 18:07:22 volumio sudo[5008]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Sep 12 18:07:22 volumio volumio[955]: info: cgui-1.0.0.zip opened Sep 12 18:07:22 volumio sudo[5008]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/LICENSE.txt Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/README.md Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/robots.txt Sep 12 18:07:22 volumio sudo[5008]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/logo512.png Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/asset-manifest.json Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/index.html Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/.put_statics_here Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/favicon.ico Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/logo192.png Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Sep 12 18:07:22 volumio sudo[5010]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Sep 12 18:07:22 volumio sudo[5010]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/manifest.json Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/css-variables.css Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/service-worker.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Sep 12 18:07:22 volumio sudo[5010]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/static/ Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/static/css/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.1503f6cd.css Sep 12 18:07:22 volumio sudo[5012]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Sep 12 18:07:22 volumio sudo[5012]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/static/media/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/static/js/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Sep 12 18:07:22 volumio sudo[5012]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.71e11955.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.71e11955.js.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/config/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/config/camillagui.yml Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/config/gui-config.yml Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/backend/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/filters_test.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/version.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/filters.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/settings.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/views.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/filterdefaults.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__init__.py Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/backend/__pycache__/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/routes.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/backend/filemanagement.py Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/main.py Sep 12 18:07:22 volumio volumio[955]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Sep 12 18:07:22 volumio volumio[955]: info: more info at http://www.winimage.com/zLibDll/unzip.html Sep 12 18:07:22 volumio volumio[955]: info: Sep 12 18:07:22 volumio volumio[955]: info: cgui-1.0.0.zip opened Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/LICENSE.txt Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/README.md Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/robots.txt Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/logo512.png Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/asset-manifest.json Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/index.html Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/.put_statics_here Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/favicon.ico Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/logo192.png Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/manifest.json Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/css-variables.css Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/service-worker.js Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/static/ Sep 12 18:07:22 volumio volumio[955]: info: creating directory: cgui/build/static/css/ Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Sep 12 18:07:22 volumio volumio[955]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/css/main.1503f6cd.css Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Sep 12 18:07:23 volumio volumio[955]: info: creating directory: cgui/build/static/media/ Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Sep 12 18:07:23 volumio volumio[955]: info: creating directory: cgui/build/static/js/ Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.71e11955.js Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.71e11955.js.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Sep 12 18:07:23 volumio volumio[955]: info: creating directory: cgui/config/ Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/config/camillagui.yml Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/config/gui-config.yml Sep 12 18:07:23 volumio volumio[955]: info: creating directory: cgui/backend/ Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/filters_test.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/version.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/filters.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/settings.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/views.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/filterdefaults.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__init__.py Sep 12 18:07:23 volumio volumio[955]: info: creating directory: cgui/backend/__pycache__/ Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/routes.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/backend/filemanagement.py Sep 12 18:07:23 volumio volumio[955]: info: extracting: cgui/main.py Sep 12 18:07:23 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:23 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:23 volumio volumio[955]: info: Listing playlists Sep 12 18:07:23 volumio volumio[955]: info: Listing playlists Sep 12 18:07:26 volumio volumio[955]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Sep 12 18:07:26 volumio volumio[955]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Sep 12 18:07:26 volumio volumio[955]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Sep 12 18:07:26 volumio volumio[955]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Sep 12 18:07:26 volumio volumio[955]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-15h296o5 Sep 12 18:07:26 volumio volumio[955]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-15h296o5 Sep 12 18:07:29 volumio volumio[955]: info: Collecting PyYAML (from camilladsp==1.0.0) Sep 12 18:07:29 volumio volumio[955]: info: Collecting PyYAML (from camilladsp==1.0.0) Sep 12 18:07:30 volumio volumio[955]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Sep 12 18:07:30 volumio volumio[955]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Sep 12 18:07:30 volumio volumio[955]: info: Collecting websocket_client (from camilladsp==1.0.0) Sep 12 18:07:30 volumio volumio[955]: info: Collecting websocket_client (from camilladsp==1.0.0) Sep 12 18:07:30 volumio volumio[955]: info: Enabling plugin spop Sep 12 18:07:30 volumio volumio[955]: info: Loading plugin "spop"... Sep 12 18:07:31 volumio volumio[955]: info: PLUGIN START: spop Sep 12 18:07:31 volumio volumio[955]: info: Creating Spotify config file Sep 12 18:07:31 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:31 volumio volumio[955]: info: Done. Sep 12 18:07:31 volumio volumio[955]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Sep 12 18:07:31 volumio volumio[955]: info: Building wheels for collected packages: camilladsp Sep 12 18:07:31 volumio volumio[955]: info: Running setup.py bdist_wheel for camilladsp: started Sep 12 18:07:31 volumio volumio[955]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Sep 12 18:07:31 volumio volumio[955]: info: Building wheels for collected packages: camilladsp Sep 12 18:07:31 volumio volumio[955]: info: Running setup.py bdist_wheel for camilladsp: started Sep 12 18:07:31 volumio volumio[955]: info: Spotify config file written Sep 12 18:07:31 volumio sudo[5055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 12 18:07:31 volumio sudo[5055]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:31 volumio volumio[955]: info: No need to fix Spotify hosts Sep 12 18:07:31 volumio systemd[1]: Started go-librespot Daemon. Sep 12 18:07:31 volumio go-librespot[5057]: go-librespot daemon starting... Sep 12 18:07:31 volumio sudo[5055]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:31 volumio go-librespot[5057]: time="2025-09-12T18:07:31+02:00" level=info msg="running go-librespot 0.3.2" Sep 12 18:07:31 volumio go-librespot[5057]: time="2025-09-12T18:07:31+02:00" level=debug msg="no app state found" Sep 12 18:07:31 volumio go-librespot[5057]: time="2025-09-12T18:07:31+02:00" level=debug msg="stored credentials not found" Sep 12 18:07:31 volumio go-librespot[5057]: time="2025-09-12T18:07:31+02:00" level=info msg="generated new device id: 66ceed5a640bcdbb4b794911d21b508d90abf302" Sep 12 18:07:31 volumio go-librespot[5057]: time="2025-09-12T18:07:31+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 12 18:07:32 volumio go-librespot[5057]: time="2025-09-12T18:07:32+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Sep 12 18:07:32 volumio go-librespot[5057]: time="2025-09-12T18:07:32+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Sep 12 18:07:32 volumio go-librespot[5057]: time="2025-09-12T18:07:32+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Sep 12 18:07:32 volumio go-librespot[5057]: time="2025-09-12T18:07:32+02:00" level=info msg="zeroconf server listening on port 38997" Sep 12 18:07:32 volumio volumio[955]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Sep 12 18:07:32 volumio volumio[955]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Sep 12 18:07:32 volumio volumio[955]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-w5y1jr7t/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Sep 12 18:07:32 volumio volumio[955]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-w5y1jr7t/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Sep 12 18:07:32 volumio volumio[955]: info: Successfully built camilladsp Sep 12 18:07:32 volumio volumio[955]: info: Successfully built camilladsp Sep 12 18:07:32 volumio volumio[955]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Sep 12 18:07:32 volumio volumio[955]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Sep 12 18:07:32 volumio volumio[955]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Sep 12 18:07:32 volumio volumio[955]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Sep 12 18:07:32 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:32 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:33 volumio volumio[955]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Sep 12 18:07:34 volumio volumio[955]: info: go-librespot daemon successfully initialized Sep 12 18:07:36 volumio volumio[955]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Sep 12 18:07:36 volumio volumio[955]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Sep 12 18:07:36 volumio volumio[955]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Sep 12 18:07:36 volumio volumio[955]: info: Check plugin dependencies Sep 12 18:07:36 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 18:07:36 volumio volumio[955]: info: Rename folder Sep 12 18:07:36 volumio volumio[955]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Sep 12 18:07:36 volumio volumio[955]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Sep 12 18:07:36 volumio volumio[955]: info: Folder /tmp/downloaded_plugin.zip removed Sep 12 18:07:36 volumio volumio[955]: info: Move to category Sep 12 18:07:36 volumio volumio[955]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-9tfe97fd Sep 12 18:07:36 volumio volumio[955]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-9tfe97fd Sep 12 18:07:38 volumio volumio[955]: info: Checking if install.sh is present Sep 12 18:07:38 volumio volumio[955]: info: Initializing connection to go-librespot Websocket Sep 12 18:07:38 volumio volumio[955]: info: Executing install.sh Sep 12 18:07:38 volumio go-librespot[5057]: time="2025-09-12T18:07:38+02:00" level=debug msg="new websocket client" Sep 12 18:07:38 volumio volumio[955]: info: Connection to go-librespot Websocket established Sep 12 18:07:38 volumio sudo[5109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Sep 12 18:07:38 volumio sudo[5109]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:38 volumio volumio[955]: info: creating filters folder and copying demo filters Sep 12 18:07:38 volumio volumio[955]: info: creating filters folder and copying demo filters Sep 12 18:07:38 volumio volumio[955]: info: creating filters folder and copying demo filters Sep 12 18:07:38 volumio volumio[955]: info: copying demo flters Sep 12 18:07:38 volumio volumio[955]: info: copying demo flters Sep 12 18:07:38 volumio volumio[955]: info: copying demo flters Sep 12 18:07:38 volumio volumio[955]: info: ./presets/ Sep 12 18:07:38 volumio volumio[955]: info: ./presets/2XEQ15/ Sep 12 18:07:38 volumio volumio[955]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Sep 12 18:07:38 volumio sudo[5136]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Sep 12 18:07:38 volumio sudo[5136]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:38 volumio volumio[955]: info: ./presets/ Sep 12 18:07:38 volumio volumio[955]: info: ./presets/2XEQ15/ Sep 12 18:07:38 volumio volumio[955]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Sep 12 18:07:38 volumio volumio[955]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/PEQ/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/kef.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/test.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Bass-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Classic-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Voice-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Rock-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: Installing/fusiondsp dependencies Sep 12 18:07:39 volumio sudo[5149]: 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 Sep 12 18:07:39 volumio sudo[5149]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Sep 12 18:07:39 volumio sudo[5149]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:39 volumio volumio[955]: info: ./presets/PEQ/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/kef.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/test.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Bass-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Classic-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Voice-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Rock-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: Installing/fusiondsp dependencies Sep 12 18:07:39 volumio sudo[5153]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Sep 12 18:07:39 volumio sudo[5153]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:39 volumio sudo[5153]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:39 volumio sudo[5156]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Sep 12 18:07:39 volumio sudo[5156]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:39 volumio volumio[955]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/PEQ/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/kef.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/convfir/test.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/ Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Bass-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Classic-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Voice-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: ./presets/EQ15/.Rock-FusionDsp.json Sep 12 18:07:39 volumio volumio[955]: info: Installing/fusiondsp dependencies Sep 12 18:07:39 volumio volumio[955]: info: Hit:1 http://archive.raspberrypi.org/debian buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Sep 12 18:07:39 volumio volumio[955]: Reading package lists... Sep 12 18:07:39 volumio volumio[955]: info: Hit:1 http://archive.raspberrypi.org/debian buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:1 http://archive.raspberrypi.org/debian buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Sep 12 18:07:39 volumio volumio[955]: info: Sep 12 18:07:39 volumio volumio[955]: Reading package lists... Sep 12 18:07:39 volumio volumio[955]: info: Sep 12 18:07:39 volumio volumio[955]: Reading package lists... Sep 12 18:07:40 volumio volumio[955]: info: Building dependency tree... Sep 12 18:07:40 volumio volumio[955]: info: Building dependency tree... Sep 12 18:07:40 volumio volumio[955]: info: Building dependency tree... Sep 12 18:07:40 volumio volumio[955]: info: Reading state information... Sep 12 18:07:40 volumio volumio[955]: info: Reading state information... Sep 12 18:07:40 volumio volumio[955]: info: Reading state information... Sep 12 18:07:41 volumio volumio[955]: info: The following NEW packages will be installed: Sep 12 18:07:41 volumio volumio[955]: info: The following NEW packages will be installed: Sep 12 18:07:41 volumio volumio[955]: info: The following NEW packages will be installed: Sep 12 18:07:41 volumio volumio[955]: info: drc Sep 12 18:07:41 volumio volumio[955]: info: drc Sep 12 18:07:41 volumio volumio[955]: info: drc Sep 12 18:07:41 volumio volumio[955]: info: Getting Spotify volume Sep 12 18:07:41 volumio volumio[955]: info: 0 upgraded, 1 newly installed, 0 to remove and 2 not upgraded. Sep 12 18:07:41 volumio volumio[955]: info: Need to get 112 kB of archives. Sep 12 18:07:41 volumio volumio[955]: info: After this operation, 512 kB of additional disk space will be used. Sep 12 18:07:41 volumio volumio[955]: info: Get:1 http://mirror1.hs-esslingen.de/pub/Mirrors/archive.raspbian.org/raspbian buster/main armhf drc armhf 3.2.2~dfsg0-2 [112 kB] Sep 12 18:07:41 volumio volumio[955]: info: 0 upgraded, 1 newly installed, 0 to remove and 2 not upgraded. Sep 12 18:07:41 volumio volumio[955]: info: Need to get 112 kB of archives. Sep 12 18:07:41 volumio volumio[955]: info: After this operation, 512 kB of additional disk space will be used. Sep 12 18:07:41 volumio volumio[955]: info: Get:1 http://mirror1.hs-esslingen.de/pub/Mirrors/archive.raspbian.org/raspbian buster/main armhf drc armhf 3.2.2~dfsg0-2 [112 kB] Sep 12 18:07:41 volumio volumio[955]: info: 0 upgraded, 1 newly installed, 0 to remove and 2 not upgraded. Sep 12 18:07:41 volumio volumio[955]: info: Need to get 112 kB of archives. Sep 12 18:07:41 volumio volumio[955]: info: After this operation, 512 kB of additional disk space will be used. Sep 12 18:07:41 volumio volumio[955]: info: Get:1 http://mirror1.hs-esslingen.de/pub/Mirrors/archive.raspbian.org/raspbian buster/main armhf drc armhf 3.2.2~dfsg0-2 [112 kB] Sep 12 18:07:42 volumio volumio[955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 12 18:07:42 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:42 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:42 volumio volumio[955]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 12 18:07:42 volumio volumio[955]: SPOTIFY: SPOTIFY VOLUME undefined Sep 12 18:07:42 volumio volumio[955]: SPOTIFY: VOLUMIO VOLUME 86 Sep 12 18:07:42 volumio volumio[955]: info: Aligning Spotify Volume to Volumio Volume Sep 12 18:07:42 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:42 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:42 volumio volumio[955]: info: Setting Spotify Volume from Volumio: 86 Sep 12 18:07:42 volumio volumio[955]: info: Fetched 112 kB in 0s (245 kB/s) Sep 12 18:07:42 volumio volumio[955]: info: Fetched 112 kB in 0s (245 kB/s) Sep 12 18:07:42 volumio volumio[955]: info: Fetched 112 kB in 0s (245 kB/s) Sep 12 18:07:42 volumio volumio[955]: info: Selecting previously unselected package drc. Sep 12 18:07:42 volumio volumio[955]: info: Selecting previously unselected package drc. Sep 12 18:07:42 volumio volumio[955]: info: Selecting previously unselected package drc. Sep 12 18:07:42 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:42 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:42 volumio volumio[955]: [620B blob data] Sep 12 18:07:42 volumio volumio[955]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Sep 12 18:07:42 volumio volumio[955]: [620B blob data] Sep 12 18:07:42 volumio volumio[955]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Sep 12 18:07:42 volumio volumio[955]: [620B blob data] Sep 12 18:07:43 volumio volumio[955]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Sep 12 18:07:43 volumio volumio[955]: info: Listing playlists Sep 12 18:07:43 volumio volumio[955]: info: Listing playlists Sep 12 18:07:43 volumio volumio[955]: info: Unpacking drc (3.2.2~dfsg0-2) ... Sep 12 18:07:43 volumio volumio[955]: info: Unpacking drc (3.2.2~dfsg0-2) ... Sep 12 18:07:43 volumio volumio[955]: info: Unpacking drc (3.2.2~dfsg0-2) ... Sep 12 18:07:43 volumio volumio[955]: SPOTIFY: SETTING SPOTIFY VOLUME 86 Sep 12 18:07:43 volumio volumio[955]: info: Sending Spotify command with payload to local API: /player/volume Sep 12 18:07:44 volumio volumio[955]: info: Setting up drc (3.2.2~dfsg0-2) ... Sep 12 18:07:44 volumio volumio[955]: info: Setting up drc (3.2.2~dfsg0-2) ... Sep 12 18:07:44 volumio volumio[955]: info: Setting up drc (3.2.2~dfsg0-2) ... Sep 12 18:07:45 volumio sudo[5136]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:45 volumio sudo[5370]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Sep 12 18:07:45 volumio sudo[5370]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:45 volumio sudo[5370]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:45 volumio sudo[5373]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Sep 12 18:07:45 volumio sudo[5373]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:45 volumio sudo[5373]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:47 volumio sudo[5392]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Sep 12 18:07:47 volumio sudo[5392]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:47 volumio sudo[5392]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:47 volumio sudo[5394]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Sep 12 18:07:47 volumio sudo[5394]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:47 volumio sudo[5394]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:47 volumio sudo[5396]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Sep 12 18:07:47 volumio sudo[5396]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:47 volumio sudo[5396]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:47 volumio sudo[5156]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:47 volumio sudo[3008]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:47 volumio volumio[955]: Plugin install end detected on script Sep 12 18:07:47 volumio volumio[955]: Plugin install end detected on script Sep 12 18:07:47 volumio volumio[955]: Plugin install end detected on script Sep 12 18:07:47 volumio volumio[955]: info: Install script completed Sep 12 18:07:47 volumio volumio[955]: info: Adding reference to registry Sep 12 18:07:48 volumio volumio[955]: info: Done installing plugin. Sep 12 18:07:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 12 18:07:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 12 18:07:48 volumio volumio[955]: info: Folder /tmp/plugins removed Sep 12 18:07:48 volumio volumio[955]: info: Folder /tmp/downloaded_plugin.zip removed Sep 12 18:07:48 volumio volumio[955]: info: Folder /data/temp removed Sep 12 18:07:50 volumio volumio[955]: info: Enabling plugin fusiondsp Sep 12 18:07:50 volumio volumio[955]: info: Loading plugin "fusiondsp"... Sep 12 18:07:51 volumio volumio[955]: info: Preparing to generate the ALSA configuration file Sep 12 18:07:51 volumio volumio[955]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 12 18:07:51 volumio volumio[955]: info: Reading ALSA contributions from plugins. Sep 12 18:07:51 volumio volumio[955]: info: Asound.conf file written Sep 12 18:07:51 volumio sudo[5417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 12 18:07:51 volumio sudo[5417]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio sudo[5417]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:51 volumio volumio[955]: No state is present for card b1 Sep 12 18:07:51 volumio volumio[955]: /usr/share/alsa/init/bcm2835:14: control element not found Sep 12 18:07:51 volumio volumio[955]: No state is present for card b1 Sep 12 18:07:51 volumio volumio[955]: No state is present for card Headphones Sep 12 18:07:51 volumio volumio[955]: /usr/share/alsa/init/bcm2835:20: control element not found Sep 12 18:07:51 volumio volumio[955]: No state is present for card Headphones Sep 12 18:07:51 volumio volumio[955]: info: Output device has changed, restarting MPD Sep 12 18:07:51 volumio sudo[5423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 18:07:51 volumio sudo[5423]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio sudo[5423]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:51 volumio volumio[955]: info: Output device has changed, restarting Shairport Sync Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 18:07:51 volumio sudo[5426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 18:07:51 volumio sudo[5426]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio systemd[1]: Stopping Music Player Daemon... Sep 12 18:07:51 volumio volumio[955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 18:07:51 volumio systemd[1]: mpd.service: Succeeded. Sep 12 18:07:51 volumio volumio[955]: info: PLUGIN START: fusiondsp Sep 12 18:07:51 volumio systemd[1]: Stopped Music Player Daemon. Sep 12 18:07:51 volumio volumio[955]: info: Loading i18n strings for locale de Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: FusionDsp - mixtype--------------------- Hardware Sep 12 18:07:51 volumio volumio[955]: info: Preparing to generate the ALSA configuration file Sep 12 18:07:51 volumio systemd[1]: Starting Music Player Daemon... Sep 12 18:07:51 volumio volumio[955]: info: Done. Sep 12 18:07:51 volumio volumio[955]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 12 18:07:51 volumio volumio[955]: info: Reading ALSA contributions from plugins. Sep 12 18:07:51 volumio volumio[955]: info: MPD Permissions set Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 18:07:51 volumio volumio[955]: info: Starting Shairport Sync Sep 12 18:07:51 volumio sudo[5431]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 12 18:07:51 volumio sudo[5431]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio sudo[5431]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:51 volumio sudo[5441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 18:07:51 volumio sudo[5441]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio volumio[955]: info: FusionDsp - Sep 12 18:07:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 12 18:07:51 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 12 18:07:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 12 18:07:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 12 18:07:51 volumio sudo[5441]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:51 volumio volumio[955]: info: Asound.conf file unchanged, so no further update is needed Sep 12 18:07:51 volumio volumio[955]: info: Output device has changed, restarting MPD Sep 12 18:07:51 volumio sudo[5451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 18:07:51 volumio sudo[5451]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio sudo[5451]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:51 volumio volumio[955]: info: Output device has changed, restarting Shairport Sync Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 18:07:51 volumio sudo[5455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 18:07:51 volumio sudo[5455]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 12 18:07:51 volumio systemd[1]: mpd.service: Succeeded. Sep 12 18:07:51 volumio systemd[1]: Stopped Music Player Daemon. Sep 12 18:07:51 volumio volumio[955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 18:07:51 volumio volumio[955]: info: FusionDsp - undefined Sep 12 18:07:51 volumio volumio[955]: info: MPD Permissions set Sep 12 18:07:51 volumio volumio[955]: info: Shairport-Sync Started Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio systemd[1]: Starting Music Player Daemon... Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:51 volumio volumio[955]: info: Starting Shairport Sync Sep 12 18:07:51 volumio sudo[5469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 18:07:51 volumio sudo[5469]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio sudo[5462]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 12 18:07:51 volumio sudo[5462]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:51 volumio sudo[5462]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:52 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 12 18:07:52 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 12 18:07:52 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 12 18:07:52 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 12 18:07:52 volumio sudo[5469]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:52 volumio volumio[955]: info: Shairport-Sync Started Sep 12 18:07:52 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:07:52 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:07:53 volumio mpd[5472]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 12 18:07:53 volumio mpd[5472]: output: No 'audio_output' defined in config file Sep 12 18:07:53 volumio mpd[5472]: output: Successfully detected a sndio audio device Sep 12 18:07:53 volumio mpd[5472]: zeroconf: No global port, disabling zeroconf Sep 12 18:07:53 volumio systemd[1]: Started Music Player Daemon. Sep 12 18:07:53 volumio sudo[5455]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:53 volumio sudo[5426]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:53 volumio volumio[955]: error: MPD error: The expression evaluated to a falsy value: Sep 12 18:07:53 volumio volumio[955]: assert.ok(self.idling) Sep 12 18:07:53 volumio volumio[955]: error: The expression evaluated to a falsy value: Sep 12 18:07:53 volumio volumio[955]: assert.ok(self.idling) Sep 12 18:07:53 volumio volumio[955]: error: updateQueue error: null Sep 12 18:07:53 volumio volumio[955]: info: camilladsp service started and running in background, instance 1 Sep 12 18:07:53 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 18:07:53 volumio volumio[955]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Sep 12 18:07:53 volumio volumio[955]: cannot open device 'volumioHw': No such device Sep 12 18:07:53 volumio volumio[955]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Sep 12 18:07:53 volumio volumio[955]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Sep 12 18:07:53 volumio volumio[955]: cannot open device 'volumioHw': No such device Sep 12 18:07:53 volumio volumio[955]: info: FusionDsp loaded Sep 12 18:07:53 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 18:07:53 volumio sudo[5496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 12 18:07:53 volumio sudo[5496]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:07:53 volumio volumio[955]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 12 18:07:53 volumio volumio[955]: info: Adding Signal Path Element [object Object] Sep 12 18:07:53 volumio volumio[955]: info: Adding fusiondspeq DSP Signal Path Element Sep 12 18:07:53 volumio volumio[955]: info: FusionDsp - ---- installed callbackRead Sep 12 18:07:53 volumio volumio[955]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 12 18:07:53 volumio volumio[955]: error: FusionDsp - WebSocket error: [object Object] Sep 12 18:07:53 volumio volumio[955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Sep 12 18:07:53 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 18:07:53 volumio sudo[5496]: pam_unix(sudo:session): session closed for user root Sep 12 18:07:54 volumio volumio[5498]: Traceback (most recent call last): Sep 12 18:07:54 volumio volumio[5498]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Sep 12 18:07:54 volumio volumio[5498]: from camilladsp_plot.validate_config import CamillaValidator Sep 12 18:07:54 volumio volumio[5498]: ModuleNotFoundError: No module named 'camilladsp_plot' Sep 12 18:07:54 volumio volumio[955]: 0+0 records in Sep 12 18:07:54 volumio volumio[955]: 0+0 records out Sep 12 18:07:54 volumio volumio[955]: 0 bytes copied, 0.000153776 s, 0.0 kB/s Sep 12 18:07:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Sep 12 18:07:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Sep 12 18:07:56 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Sep 12 18:07:56 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Sep 12 18:07:56 volumio systemd[1]: Stopped FusionDsp Daemon. Sep 12 18:07:56 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 18:07:57 volumio volumio[5803]: Traceback (most recent call last): Sep 12 18:07:57 volumio volumio[5803]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Sep 12 18:07:57 volumio volumio[5803]: from camilladsp_plot.validate_config import CamillaValidator Sep 12 18:07:57 volumio volumio[5803]: ModuleNotFoundError: No module named 'camilladsp_plot' Sep 12 18:07:57 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Sep 12 18:07:57 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Sep 12 18:07:59 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Sep 12 18:07:59 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2. Sep 12 18:07:59 volumio systemd[1]: Stopped FusionDsp Daemon. Sep 12 18:08:00 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 18:08:00 volumio volumio[6238]: Traceback (most recent call last): Sep 12 18:08:00 volumio volumio[6238]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Sep 12 18:08:00 volumio volumio[6238]: from camilladsp_plot.validate_config import CamillaValidator Sep 12 18:08:00 volumio volumio[6238]: ModuleNotFoundError: No module named 'camilladsp_plot' Sep 12 18:08:01 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Sep 12 18:08:01 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Sep 12 18:08:02 volumio volumio[955]: info: CoreCommandRouter::volumioGetState Sep 12 18:08:02 volumio volumio[955]: info: CorePlayQueue::getTrack 0 Sep 12 18:08:02 volumio volumio[955]: info: Listing playlists Sep 12 18:08:02 volumio volumio[955]: info: Listing playlists Sep 12 18:08:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Sep 12 18:08:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 3. Sep 12 18:08:03 volumio systemd[1]: Stopped FusionDsp Daemon. Sep 12 18:08:03 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 18:08:03 volumio volumio[955]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio-buttons/volumio/buster/armhf Sep 12 18:08:04 volumio volumio[6674]: Traceback (most recent call last): Sep 12 18:08:04 volumio volumio[6674]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Sep 12 18:08:04 volumio volumio[6674]: from camilladsp_plot.validate_config import CamillaValidator Sep 12 18:08:04 volumio volumio[6674]: ModuleNotFoundError: No module named 'camilladsp_plot' Sep 12 18:08:04 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Sep 12 18:08:04 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Sep 12 18:08:06 volumio volumio[955]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio-buttons/volumio/buster/armhf Sep 12 18:08:06 volumio volumio[955]: info: Folder /tmp/plugins removed Sep 12 18:08:06 volumio volumio[955]: info: Check plugin dependencies Sep 12 18:08:06 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 18:08:06 volumio volumio[955]: info: Checking if plugin already exists Sep 12 18:08:06 volumio volumio[955]: info: Rename folder Sep 12 18:08:06 volumio volumio[955]: info: Folder /tmp/downloaded_plugin.zip removed Sep 12 18:08:06 volumio volumio[955]: info: Move to category Sep 12 18:08:06 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Sep 12 18:08:06 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 4. Sep 12 18:08:06 volumio systemd[1]: Stopped FusionDsp Daemon. Sep 12 18:08:06 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 18:08:07 volumio volumio[955]: info: Checking if install.sh is present Sep 12 18:08:07 volumio volumio[955]: info: Executing install.sh Sep 12 18:08:07 volumio sudo[7120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/gpio-buttons/install.sh Sep 12 18:08:07 volumio sudo[7120]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:08:07 volumio sudo[7120]: pam_unix(sudo:session): session closed for user root Sep 12 18:08:07 volumio volumio[955]: info: Initializing config Sep 12 18:08:07 volumio volumio[955]: Plugin install end detected on script Sep 12 18:08:07 volumio volumio[955]: info: Install script completed Sep 12 18:08:07 volumio volumio[955]: info: Adding reference to registry Sep 12 18:08:07 volumio volumio[955]: info: Done installing plugin. Sep 12 18:08:07 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 12 18:08:07 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 12 18:08:07 volumio volumio[955]: info: Folder /tmp/downloaded_plugin.zip removed Sep 12 18:08:07 volumio volumio[955]: info: Folder /tmp/plugins removed Sep 12 18:08:07 volumio volumio[955]: info: Folder /data/temp removed Sep 12 18:08:07 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 18:08:07 volumio volumio[955]: info: FusionDsp - Sep 12 18:08:07 volumio volumio[955]: info: FusionDsp - undefined Sep 12 18:08:07 volumio volumio[7113]: Traceback (most recent call last): Sep 12 18:08:07 volumio volumio[7113]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Sep 12 18:08:07 volumio volumio[7113]: from camilladsp_plot.validate_config import CamillaValidator Sep 12 18:08:07 volumio volumio[7113]: ModuleNotFoundError: No module named 'camilladsp_plot' Sep 12 18:08:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Sep 12 18:08:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Sep 12 18:08:09 volumio volumio[955]: info: Enabling plugin gpio-buttons Sep 12 18:08:09 volumio volumio[955]: info: Loading plugin "gpio-buttons"... Sep 12 18:08:09 volumio volumio[955]: info: GPIO-Buttons initialized Sep 12 18:08:09 volumio volumio[955]: info: PLUGIN START: gpio-buttons Sep 12 18:08:09 volumio volumio[955]: info: GPIO-Buttons: Reading config and creating triggers... Sep 12 18:08:09 volumio volumio[955]: info: GPIO-Buttons started Sep 12 18:08:09 volumio volumio[955]: info: Done. Sep 12 18:08:09 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 18:08:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Sep 12 18:08:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 5. Sep 12 18:08:09 volumio systemd[1]: Stopped FusionDsp Daemon. Sep 12 18:08:09 volumio volumio[955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Sep 12 18:08:09 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 18:08:09 volumio volumio[955]: info: FusionDsp - Sep 12 18:08:09 volumio volumio[955]: info: FusionDsp - undefined Sep 12 18:08:10 volumio volumio[955]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 18:08:10 volumio volumio[955]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES Sep 12 18:08:10 volumio volumio[955]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Sep 12 18:08:10 volumio volumio[955]: at onErrorNT (internal/child_process.js:465:16) Sep 12 18:08:10 volumio volumio[955]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Sep 12 18:08:10 volumio volumio[955]: errno: -13, Sep 12 18:08:10 volumio volumio[955]: code: 'EACCES', Sep 12 18:08:10 volumio volumio[955]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 12 18:08:10 volumio volumio[955]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 12 18:08:10 volumio volumio[955]: spawnargs: [ Sep 12 18:08:10 volumio volumio[955]: '-p', Sep 12 18:08:10 volumio volumio[955]: 9876, Sep 12 18:08:10 volumio volumio[955]: '-o', Sep 12 18:08:10 volumio volumio[955]: '/tmp/camilladsp.log', Sep 12 18:08:10 volumio volumio[955]: '-l', Sep 12 18:08:10 volumio volumio[955]: 'warn', Sep 12 18:08:10 volumio volumio[955]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 12 18:08:10 volumio volumio[955]: ] Sep 12 18:08:10 volumio volumio[955]: } Sep 12 18:08:10 volumio volumio[955]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 18:08:10 volumio sudo[7475]: 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 Sep 12 18:08:10 volumio sudo[7475]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:08:10 volumio sudo[7475]: pam_unix(sudo:session): session closed for user root Sep 12 18:08:10 volumio sudo[7482]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Sep 12 18:08:10 volumio sudo[7482]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:08:10 volumio sudo[7482]: pam_unix(sudo:session): session closed for user root Sep 12 18:08:10 volumio sudo[7485]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Sep 12 18:08:10 volumio sudo[7485]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 18:08:10 volumio sudo[7490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 18:07 Sep 12 18:08:10 volumio sudo[7490]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"