-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-08-30 16:54:15 CEST. -- Aug 30 16:53:00 volumio volumio[897]: info: go-librespot daemon successfully initialized Aug 30 16:53:01 volumio volumio[897]: info: Setting up python3-entrypoints (0.3-1) ... Aug 30 16:53:01 volumio volumio[897]: info: Setting up python3-entrypoints (0.3-1) ... Aug 30 16:53:02 volumio volumio[897]: info: Setting up dh-python (3.20190308) ... Aug 30 16:53:02 volumio volumio[897]: info: Setting up dh-python (3.20190308) ... Aug 30 16:53:02 volumio volumio[897]: info: Setting up python3-attr (18.2.0-1) ... Aug 30 16:53:02 volumio volumio[897]: info: Setting up python3-attr (18.2.0-1) ... Aug 30 16:53:03 volumio volumio[897]: info: Setting up python3-dbus (1.2.8-3) ... Aug 30 16:53:03 volumio volumio[897]: info: Setting up python3-dbus (1.2.8-3) ... Aug 30 16:53:03 volumio volumio[897]: info: Setting up python3-setuptools (40.8.0-1) ... Aug 30 16:53:03 volumio volumio[897]: info: Setting up python3-setuptools (40.8.0-1) ... Aug 30 16:53:03 volumio volumio[897]: info: Initializing connection to go-librespot Websocket Aug 30 16:53:03 volumio go-librespot[4299]: time="2024-08-30T16:53:03+02:00" level=debug msg="new websocket client" Aug 30 16:53:03 volumio volumio[897]: info: Connection to go-librespot Websocket established Aug 30 16:53:04 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:04 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:04 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:04 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:04 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:04 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:05 volumio volumio[897]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Aug 30 16:53:05 volumio volumio[897]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up python3-xdg (0.25-5) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up python3-xdg (0.25-5) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up python3-wheel (0.32.3-2) ... Aug 30 16:53:06 volumio volumio[897]: info: Setting up python3-wheel (0.32.3-2) ... Aug 30 16:53:06 volumio volumio[897]: info: Getting Spotify volume Aug 30 16:53:06 volumio volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 30 16:53:06 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:06 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:06 volumio volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 30 16:53:06 volumio volumio[897]: SPOTIFY: SPOTIFY VOLUME undefined Aug 30 16:53:06 volumio volumio[897]: SPOTIFY: VOLUMIO VOLUME 100 Aug 30 16:53:06 volumio volumio[897]: info: Aligning Spotify Volume to Volumio Volume Aug 30 16:53:06 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:06 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:06 volumio volumio[897]: info: Setting Spotify Volume from Volumio: 100 Aug 30 16:53:07 volumio volumio[897]: info: Setting up python3-multidict (4.5.2-1) ... Aug 30 16:53:07 volumio volumio[897]: info: Setting up python3-multidict (4.5.2-1) ... Aug 30 16:53:07 volumio volumio[897]: info: Setting up libfakeroot:armhf (1.23-1) ... Aug 30 16:53:07 volumio volumio[897]: info: Setting up libfakeroot:armhf (1.23-1) ... Aug 30 16:53:07 volumio volumio[897]: info: Setting up python3-async-timeout (3.0.1-1) ... Aug 30 16:53:07 volumio volumio[897]: info: Setting up python3-async-timeout (3.0.1-1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up fakeroot (1.23-1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up fakeroot (1.23-1) ... Aug 30 16:53:08 volumio volumio[897]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Aug 30 16:53:08 volumio volumio[897]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: 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 Aug 30 16:53:08 volumio volumio[897]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Aug 30 16:53:08 volumio volumio[897]: info: Sending Spotify command with payload to local API: /player/volume Aug 30 16:53:08 volumio volumio[897]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up make (4.2.1-1.2) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up python3-gi (3.30.4-1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up make (4.2.1-1.2) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Aug 30 16:53:08 volumio volumio[897]: info: Setting up python3-gi (3.30.4-1) ... Aug 30 16:53:09 volumio volumio[897]: info: Setting up libmpc3:armhf (1.1.0-1) ... Aug 30 16:53:09 volumio volumio[897]: info: Setting up libmpc3:armhf (1.1.0-1) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up patch (2.7.6-3+deb10u1) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up patch (2.7.6-3+deb10u1) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up libisl19:armhf (0.20-2) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up libisl19:armhf (0.20-2) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up python3-crypto (2.6.1-9+b1) ... Aug 30 16:53:11 volumio volumio[897]: info: Setting up python3-crypto (2.6.1-9+b1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up python3-yarl (1.3.0-1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up python3-yarl (1.3.0-1) ... Aug 30 16:53:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:12 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:12 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:12 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:12 volumio volumio[897]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up python3-asn1crypto (0.24.0-1) ... Aug 30 16:53:12 volumio volumio[897]: info: Setting up python3-asn1crypto (0.24.0-1) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up python3-cffi-backend (1.12.2-1) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up python3-cffi-backend (1.12.2-1) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Aug 30 16:53:13 volumio volumio[897]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Aug 30 16:53:16 volumio volumio[897]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Aug 30 16:53:16 volumio volumio[897]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Aug 30 16:53:16 volumio volumio[897]: info: Setting up dpkg-dev (1.19.8) ... Aug 30 16:53:16 volumio volumio[897]: info: Setting up dpkg-dev (1.19.8) ... Aug 30 16:53:19 volumio volumio[897]: info: Enabling plugin spop Aug 30 16:53:19 volumio volumio[897]: info: Loading plugin "spop"... Aug 30 16:53:20 volumio volumio[897]: info: PLUGIN START: spop Aug 30 16:53:20 volumio volumio[897]: info: Creating Spotify config file Aug 30 16:53:20 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:53:20 volumio volumio[897]: info: Done. Aug 30 16:53:20 volumio volumio[897]: info: Spotify config file written Aug 30 16:53:20 volumio volumio[897]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Aug 30 16:53:20 volumio sudo[4533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 30 16:53:20 volumio sudo[4533]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:53:20 volumio volumio[897]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Aug 30 16:53:20 volumio systemd[1]: Stopping go-librespot Daemon... Aug 30 16:53:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Aug 30 16:53:20 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Aug 30 16:53:20 volumio systemd[1]: Stopped go-librespot Daemon. Aug 30 16:53:20 volumio volumio[897]: info: Connection to go-librespot Websocket closed Aug 30 16:53:20 volumio systemd[1]: Started go-librespot Daemon. Aug 30 16:53:20 volumio go-librespot[4538]: Librespot-go daemon starting... Aug 30 16:53:20 volumio sudo[4533]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:20 volumio go-librespot[4538]: time="2024-08-30T16:53:20+02:00" level=info msg="generated new device id: 4777cbafeae913a259affaf5292aa07c757cf719" Aug 30 16:53:20 volumio volumio[897]: info: Enabling plugin spop Aug 30 16:53:20 volumio volumio[897]: info: Loading plugin "spop"... Aug 30 16:53:20 volumio volumio[897]: info: PLUGIN START: spop Aug 30 16:53:20 volumio volumio[897]: info: Creating Spotify config file Aug 30 16:53:20 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:53:20 volumio volumio[897]: info: Done. Aug 30 16:53:20 volumio volumio[897]: info: Spotify config file written Aug 30 16:53:20 volumio go-librespot[4538]: time="2024-08-30T16:53:20+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 16:53:20 volumio go-librespot[4538]: time="2024-08-30T16:53:20+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 16:53:20 volumio go-librespot[4538]: time="2024-08-30T16:53:20+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 16:53:20 volumio go-librespot[4538]: time="2024-08-30T16:53:20+02:00" level=debug msg="zeroconf server listening on port 37723" Aug 30 16:53:20 volumio sudo[4554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 30 16:53:20 volumio sudo[4554]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:53:20 volumio systemd[1]: Stopping go-librespot Daemon... Aug 30 16:53:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Aug 30 16:53:20 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Aug 30 16:53:20 volumio systemd[1]: Stopped go-librespot Daemon. Aug 30 16:53:21 volumio systemd[1]: Started go-librespot Daemon. Aug 30 16:53:21 volumio go-librespot[4558]: Librespot-go daemon starting... Aug 30 16:53:21 volumio sudo[4554]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:21 volumio go-librespot[4558]: time="2024-08-30T16:53:21+02:00" level=info msg="generated new device id: eccbe21e0fc5a6fd5342c205e6cb9e0daecba079" Aug 30 16:53:21 volumio go-librespot[4558]: time="2024-08-30T16:53:21+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 16:53:21 volumio go-librespot[4558]: time="2024-08-30T16:53:21+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 16:53:21 volumio go-librespot[4558]: time="2024-08-30T16:53:21+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 16:53:21 volumio go-librespot[4558]: time="2024-08-30T16:53:21+02:00" level=debug msg="zeroconf server listening on port 33783" Aug 30 16:53:21 volumio volumio[897]: info: Setting up python3-pip (18.1-5+rpt1) ... Aug 30 16:53:21 volumio volumio[897]: info: Setting up python3-pip (18.1-5+rpt1) ... Aug 30 16:53:22 volumio volumio[897]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:22 volumio volumio[897]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:22 volumio volumio[897]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Aug 30 16:53:22 volumio volumio[897]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Aug 30 16:53:23 volumio volumio[897]: info: Initializing connection to go-librespot Websocket Aug 30 16:53:23 volumio go-librespot[4558]: time="2024-08-30T16:53:23+02:00" level=debug msg="new websocket client" Aug 30 16:53:23 volumio volumio[897]: info: Connection to go-librespot Websocket established Aug 30 16:53:23 volumio volumio[897]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Aug 30 16:53:23 volumio volumio[897]: info: go-librespot daemon successfully initialized Aug 30 16:53:23 volumio volumio[897]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up python3-secretstorage (2.3.1-2) ... Aug 30 16:53:23 volumio volumio[897]: info: Setting up python3-secretstorage (2.3.1-2) ... Aug 30 16:53:24 volumio volumio[897]: info: go-librespot daemon successfully initialized Aug 30 16:53:24 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:24 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:24 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:24 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:24 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:24 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:24 volumio volumio[897]: info: Setting up python3-dev (3.7.3-1) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up python3-dev (3.7.3-1) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up python3-keyring (17.1.1-1) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up python3-keyring (17.1.1-1) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Aug 30 16:53:24 volumio volumio[897]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Aug 30 16:53:25 volumio volumio[897]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Aug 30 16:53:25 volumio volumio[897]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Aug 30 16:53:25 volumio volumio[897]: info: Setting up build-essential (12.6) ... Aug 30 16:53:25 volumio volumio[897]: info: Setting up build-essential (12.6) ... Aug 30 16:53:25 volumio volumio[897]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Aug 30 16:53:25 volumio volumio[897]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Aug 30 16:53:26 volumio sudo[3582]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:26 volumio sudo[4639]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Aug 30 16:53:26 volumio sudo[4639]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:53:26 volumio volumio[897]: info: lib/systemd/system/fusiondsp.service Aug 30 16:53:26 volumio sudo[4639]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:26 volumio volumio[897]: info: lib/systemd/system/fusiondsp.service Aug 30 16:53:26 volumio volumio[897]: info: Getting Spotify volume Aug 30 16:53:26 volumio volumio[897]: info: Initializing connection to go-librespot Websocket Aug 30 16:53:26 volumio go-librespot[4558]: time="2024-08-30T16:53:26+02:00" level=debug msg="new websocket client" Aug 30 16:53:26 volumio volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 30 16:53:26 volumio volumio[897]: info: Connection to go-librespot Websocket established Aug 30 16:53:26 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:26 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:26 volumio volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 30 16:53:27 volumio volumio[897]: info: Initializing connection to go-librespot Websocket Aug 30 16:53:27 volumio go-librespot[4558]: time="2024-08-30T16:53:27+02:00" level=debug msg="new websocket client" Aug 30 16:53:27 volumio volumio[897]: info: Connection to go-librespot Websocket established Aug 30 16:53:29 volumio volumio[897]: info: Getting Spotify volume Aug 30 16:53:29 volumio volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 30 16:53:29 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:29 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:29 volumio volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 30 16:53:30 volumio volumio[897]: info: Getting Spotify volume Aug 30 16:53:30 volumio volumio[897]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Aug 30 16:53:30 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:30 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:30 volumio volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 30 16:53:30 volumio volumio[897]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Aug 30 16:53:30 volumio sudo[4644]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Aug 30 16:53:30 volumio sudo[4644]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:53:30 volumio volumio[897]: info: more info at http://www.winimage.com/zLibDll/unzip.html Aug 30 16:53:30 volumio volumio[897]: info: Aug 30 16:53:30 volumio sudo[4644]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:30 volumio volumio[897]: info: cgui-1.0.0.zip opened Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/LICENSE.txt Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/README.md Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/build/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/robots.txt Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/logo512.png Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/asset-manifest.json Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/index.html Aug 30 16:53:30 volumio sudo[4646]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Aug 30 16:53:30 volumio sudo[4646]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/.put_statics_here Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/favicon.ico Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/logo192.png Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/manifest.json Aug 30 16:53:30 volumio sudo[4646]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/css-variables.css Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/service-worker.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/build/static/ Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/build/static/css/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Aug 30 16:53:30 volumio sudo[4648]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/main.1503f6cd.css Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Aug 30 16:53:30 volumio sudo[4648]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/build/static/media/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/build/static/js/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.71e11955.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.71e11955.js.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/config/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/config/camillagui.yml Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/config/gui-config.yml Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/backend/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/filters_test.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/version.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/filters.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/settings.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/views.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/filterdefaults.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__init__.py Aug 30 16:53:30 volumio volumio[897]: info: creating directory: cgui/backend/__pycache__/ Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/routes.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/backend/filemanagement.py Aug 30 16:53:30 volumio volumio[897]: info: extracting: cgui/main.py Aug 30 16:53:31 volumio volumio[897]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Aug 30 16:53:31 volumio volumio[897]: info: more info at http://www.winimage.com/zLibDll/unzip.html Aug 30 16:53:31 volumio volumio[897]: info: Aug 30 16:53:31 volumio volumio[897]: info: cgui-1.0.0.zip opened Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/LICENSE.txt Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/README.md Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/build/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/robots.txt Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/logo512.png Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/asset-manifest.json Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/index.html Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/.put_statics_here Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/favicon.ico Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/logo192.png Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/manifest.json Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/css-variables.css Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/service-worker.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/build/static/ Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/build/static/css/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/main.1503f6cd.css Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/build/static/media/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/build/static/js/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.71e11955.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.71e11955.js.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/config/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/config/camillagui.yml Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/config/gui-config.yml Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/backend/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/filters_test.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/version.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/filters.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/settings.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/views.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/filterdefaults.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__init__.py Aug 30 16:53:31 volumio volumio[897]: info: creating directory: cgui/backend/__pycache__/ Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/routes.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/backend/filemanagement.py Aug 30 16:53:31 volumio volumio[897]: info: extracting: cgui/main.py Aug 30 16:53:35 volumio sudo[4648]: pam_unix(sudo:session): session closed for user root Aug 30 16:53:37 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:37 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:37 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:37 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:37 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:37 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:42 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:42 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:42 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:42 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:42 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:42 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:44 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:44 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:44 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:44 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:44 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:44 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:48 volumio volumio[897]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 30 16:53:48 volumio volumio[897]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 30 16:53:48 volumio volumio[897]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Aug 30 16:53:48 volumio volumio[897]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-1y2ko5tq Aug 30 16:53:48 volumio volumio[897]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Aug 30 16:53:48 volumio volumio[897]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-1y2ko5tq Aug 30 16:53:50 volumio volumio[897]: info: Collecting PyYAML (from camilladsp==1.0.0) Aug 30 16:53:50 volumio volumio[897]: info: Collecting PyYAML (from camilladsp==1.0.0) Aug 30 16:53:51 volumio volumio[897]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Aug 30 16:53:52 volumio volumio[897]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Aug 30 16:53:52 volumio volumio[897]: info: Collecting websocket_client (from camilladsp==1.0.0) Aug 30 16:53:52 volumio volumio[897]: info: Collecting websocket_client (from camilladsp==1.0.0) Aug 30 16:53:52 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Aug 30 16:53:52 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Aug 30 16:53:52 volumio volumio[897]: info: Building wheels for collected packages: camilladsp Aug 30 16:53:52 volumio volumio[897]: info: Building wheels for collected packages: camilladsp Aug 30 16:53:52 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp: started Aug 30 16:53:52 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp: started Aug 30 16:53:53 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Aug 30 16:53:53 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Aug 30 16:53:53 volumio volumio[897]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-t3spdnuy/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Aug 30 16:53:53 volumio volumio[897]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-t3spdnuy/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Aug 30 16:53:53 volumio volumio[897]: info: Successfully built camilladsp Aug 30 16:53:53 volumio volumio[897]: info: Successfully built camilladsp Aug 30 16:53:53 volumio volumio[897]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Aug 30 16:53:53 volumio volumio[897]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Aug 30 16:53:54 volumio volumio[897]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Aug 30 16:53:54 volumio volumio[897]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Aug 30 16:53:57 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:53:57 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:53:57 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:53:57 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:53:57 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:53:57 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:53:57 volumio volumio[897]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 30 16:53:57 volumio volumio[897]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 30 16:53:57 volumio volumio[897]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Aug 30 16:53:57 volumio volumio[897]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Aug 30 16:53:57 volumio volumio[897]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-_j7djkeo Aug 30 16:53:57 volumio volumio[897]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-_j7djkeo Aug 30 16:53:59 volumio volumio[897]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Aug 30 16:53:59 volumio volumio[897]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Aug 30 16:53:59 volumio volumio[897]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Aug 30 16:53:59 volumio volumio[897]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Aug 30 16:54:01 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Aug 30 16:54:01 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Aug 30 16:54:01 volumio volumio[897]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:01 volumio volumio[897]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:02 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Aug 30 16:54:02 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Aug 30 16:54:02 volumio volumio[897]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:02 volumio volumio[897]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:02 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Aug 30 16:54:02 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Aug 30 16:54:03 volumio volumio[897]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:03 volumio volumio[897]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:04 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:54:04 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:54:04 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:54:04 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:54:04 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:54:04 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:54:04 volumio volumio[897]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Aug 30 16:54:04 volumio volumio[897]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Aug 30 16:54:04 volumio volumio[897]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:04 volumio volumio[897]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:04 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Aug 30 16:54:04 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Aug 30 16:54:04 volumio volumio[897]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:04 volumio volumio[897]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:05 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Aug 30 16:54:05 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Aug 30 16:54:05 volumio volumio[897]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Aug 30 16:54:05 volumio volumio[897]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Aug 30 16:54:05 volumio volumio[897]: info: Collecting zipp>=0.5 (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:05 volumio volumio[897]: info: Collecting zipp>=0.5 (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) Aug 30 16:54:05 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Aug 30 16:54:05 volumio volumio[897]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Aug 30 16:54:05 volumio volumio[897]: info: Building wheels for collected packages: camilladsp-plot Aug 30 16:54:05 volumio volumio[897]: info: Building wheels for collected packages: camilladsp-plot Aug 30 16:54:05 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp-plot: started Aug 30 16:54:05 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp-plot: started Aug 30 16:54:06 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Aug 30 16:54:06 volumio volumio[897]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Aug 30 16:54:06 volumio volumio[897]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-e60y_0sp/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Aug 30 16:54:06 volumio volumio[897]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-e60y_0sp/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Aug 30 16:54:06 volumio volumio[897]: info: Successfully built camilladsp-plot Aug 30 16:54:06 volumio volumio[897]: info: Successfully built camilladsp-plot Aug 30 16:54:10 volumio volumio[897]: info: Enabling plugin fusiondsp Aug 30 16:54:10 volumio volumio[897]: info: Loading plugin "fusiondsp"... Aug 30 16:54:12 volumio volumio[897]: info: Preparing to generate the ALSA configuration file Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 16:54:12 volumio volumio[897]: info: Discovery: Getting this device information Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::volumioGetState Aug 30 16:54:12 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:54:12 volumio volumio[897]: info: Asound.conf file unchanged, so no further update is needed Aug 30 16:54:12 volumio volumio[897]: info: Output device has changed, restarting MPD Aug 30 16:54:12 volumio sudo[4755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 16:54:12 volumio sudo[4755]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:12 volumio sudo[4755]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:12 volumio volumio[897]: info: Output device has changed, restarting Shairport Sync Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 16:54:12 volumio sudo[4758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 16:54:12 volumio sudo[4758]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:12 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 16:54:12 volumio systemd[1]: mpd.service: Succeeded. Aug 30 16:54:12 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 16:54:12 volumio volumio[897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 16:54:12 volumio volumio[897]: info: PLUGIN START: fusiondsp Aug 30 16:54:12 volumio volumio[897]: info: Loading i18n strings for locale de Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 16:54:12 volumio volumio[897]: info: Preparing to generate the ALSA configuration file Aug 30 16:54:12 volumio volumio[897]: info: Done. Aug 30 16:54:12 volumio volumio[897]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 16:54:12 volumio volumio[897]: info: Reading ALSA contributions from plugins. Aug 30 16:54:12 volumio volumio[897]: info: MPD Permissions set Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio systemd[1]: Starting Music Player Daemon... Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:12 volumio volumio[897]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 16:54:12 volumio volumio[897]: info: Starting Shairport Sync Aug 30 16:54:12 volumio sudo[4763]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 16:54:12 volumio sudo[4763]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:12 volumio sudo[4763]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:12 volumio sudo[4769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 16:54:12 volumio sudo[4769]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 16:54:12 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 16:54:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 16:54:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 16:54:12 volumio sudo[4769]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:13 volumio volumio[897]: info: Shairport-Sync Started Aug 30 16:54:13 volumio volumio[897]: info: Installing collected packages: zipp, typing-extensions, importlib-metadata, importlib-resources, pyrsistent, pkgutil-resolve-name, jsonschema, camilladsp-plot Aug 30 16:54:13 volumio volumio[897]: info: Installing collected packages: zipp, typing-extensions, importlib-metadata, importlib-resources, pyrsistent, pkgutil-resolve-name, jsonschema, camilladsp-plot Aug 30 16:54:13 volumio volumio[897]: info: Asound.conf file written Aug 30 16:54:13 volumio sudo[4777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 30 16:54:13 volumio sudo[4777]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:13 volumio sudo[4777]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:13 volumio volumio[897]: No state is present for card b1 Aug 30 16:54:13 volumio volumio[897]: /usr/share/alsa/init/bcm2835:14: control element not found Aug 30 16:54:13 volumio volumio[897]: No state is present for card b1 Aug 30 16:54:13 volumio volumio[897]: No state is present for card Headphones Aug 30 16:54:13 volumio volumio[897]: /usr/share/alsa/init/bcm2835:20: control element not found Aug 30 16:54:13 volumio volumio[897]: No state is present for card Headphones Aug 30 16:54:13 volumio volumio[897]: No state is present for card sndrpihifiberry Aug 30 16:54:13 volumio volumio[897]: Found hardware: "HifiberryDacp" "" "" "" "" Aug 30 16:54:13 volumio volumio[897]: Hardware is initialized using a generic method Aug 30 16:54:13 volumio volumio[897]: No state is present for card sndrpihifiberry Aug 30 16:54:13 volumio volumio[897]: info: Output device has changed, restarting MPD Aug 30 16:54:13 volumio sudo[4782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 16:54:13 volumio sudo[4782]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:13 volumio sudo[4782]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:13 volumio volumio[897]: info: Output device has changed, restarting Shairport Sync Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 16:54:13 volumio sudo[4785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 16:54:13 volumio sudo[4785]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:13 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 16:54:13 volumio systemd[1]: mpd.service: Succeeded. Aug 30 16:54:13 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 16:54:13 volumio volumio[897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 16:54:13 volumio volumio[897]: info: MPD Permissions set Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio systemd[1]: Starting Music Player Daemon... Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:13 volumio volumio[897]: info: Starting Shairport Sync Aug 30 16:54:13 volumio sudo[4790]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 16:54:13 volumio sudo[4790]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:13 volumio sudo[4796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 16:54:13 volumio sudo[4796]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:13 volumio sudo[4790]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 16:54:13 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 16:54:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 16:54:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 16:54:13 volumio sudo[4796]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:13 volumio volumio[897]: info: Shairport-Sync Started Aug 30 16:54:13 volumio volumio[897]: 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 Aug 30 16:54:13 volumio volumio[897]: 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 Aug 30 16:54:13 volumio volumio[897]: info: copying hw detection script Aug 30 16:54:14 volumio volumio[897]: info: copying hw detection script Aug 30 16:54:14 volumio volumio[897]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 16:54:14 volumio volumio[897]: info: Detected cpu architecture as armv7l Aug 30 16:54:14 volumio volumio[897]: info: Detected cpu architecture as armv7l Aug 30 16:54:14 volumio mpd[4799]: Aug 30 16:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 16:54:14 volumio systemd[1]: Started Music Player Daemon. Aug 30 16:54:14 volumio sudo[4758]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:14 volumio sudo[4785]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:14 volumio volumio[897]: error: MPD error: The expression evaluated to a falsy value: Aug 30 16:54:14 volumio volumio[897]: assert.ok(self.idling) Aug 30 16:54:14 volumio volumio[897]: error: The expression evaluated to a falsy value: Aug 30 16:54:14 volumio volumio[897]: assert.ok(self.idling) Aug 30 16:54:14 volumio volumio[897]: error: updateQueue error: null Aug 30 16:54:14 volumio volumio[897]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 30 16:54:14 volumio volumio[897]: info: camilladsp service started and running in background, instance 1 Aug 30 16:54:14 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 16:54:14 volumio volumio[897]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 16:54:14 volumio volumio[897]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 16:54:14 volumio volumio[897]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 16:54:14 volumio volumio[897]: info: FusionDsp loaded Aug 30 16:54:14 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 16:54:14 volumio sudo[4819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 16:54:14 volumio sudo[4819]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 16:54:14 volumio volumio[897]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 16:54:14 volumio volumio[897]: info: Adding Signal Path Element [object Object] Aug 30 16:54:14 volumio volumio[897]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 16:54:14 volumio volumio[897]: info: FusionDsp - ---- installed callbackRead Aug 30 16:54:14 volumio volumio[897]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 16:54:14 volumio volumio[897]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 16:54:14 volumio volumio[897]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 16:54:14 volumio volumio[897]: at onErrorNT (internal/child_process.js:465:16) Aug 30 16:54:14 volumio volumio[897]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 16:54:14 volumio volumio[897]: errno: -2, Aug 30 16:54:14 volumio volumio[897]: code: 'ENOENT', Aug 30 16:54:14 volumio volumio[897]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 16:54:14 volumio volumio[897]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 16:54:14 volumio volumio[897]: spawnargs: [ Aug 30 16:54:14 volumio volumio[897]: '-p', Aug 30 16:54:14 volumio volumio[897]: 9876, Aug 30 16:54:14 volumio volumio[897]: '-o', Aug 30 16:54:14 volumio volumio[897]: '/tmp/camilladsp.log', Aug 30 16:54:14 volumio volumio[897]: '-l', Aug 30 16:54:14 volumio volumio[897]: 'warn', Aug 30 16:54:14 volumio volumio[897]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 16:54:14 volumio volumio[897]: ] Aug 30 16:54:14 volumio volumio[897]: } Aug 30 16:54:14 volumio volumio[897]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 16:54:15 volumio systemd[1]: Started FusionDsp Daemon. Aug 30 16:54:15 volumio sudo[4819]: pam_unix(sudo:session): session closed for user root Aug 30 16:54:15 volumio sudo[4831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 16:53 Aug 30 16:54:15 volumio sudo[4831]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"