-- Logs begin at Wed 2024-09-04 01:18:43 UTC, end at Wed 2024-09-04 06:47:11 UTC. -- Sep 04 06:46:19 volumio volumio-remote-updater[754]: [2024-09-04 06:46:19] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Sep 04 06:46:24 volumio volumio-remote-updater[754]: [2024-09-04 06:46:24] [connect] Successful connection Sep 04 06:46:32 volumio volumio[3282]: info: Checking if install.sh is present Sep 04 06:46:32 volumio volumio[3282]: info: Executing install.sh Sep 04 06:46:32 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Sep 04 06:46:32 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Sep 04 06:46:32 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Sep 04 06:46:32 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 04 06:46:32 volumio sudo[7853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Sep 04 06:46:32 volumio sudo[7853]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:46:32 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 04 06:46:32 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 04 06:46:32 volumio volumio[3282]: info: copying demo flters Sep 04 06:46:32 volumio volumio[3282]: info: Installing/fusiondsp dependencies Sep 04 06:46:32 volumio sudo[7874]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Sep 04 06:46:32 volumio sudo[7874]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:46:32 volumio volumio[3282]: info: Hit:1 http://deb.debian.org/debian buster InRelease Sep 04 06:46:32 volumio volumio[3282]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Sep 04 06:46:33 volumio volumio[3282]: 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 04 06:46:33 volumio volumio[3282]: info: CoreCommandRouter::volumioGetState Sep 04 06:46:33 volumio volumio[3282]: 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 04 06:46:33 volumio volumio[3282]: info: CoreCommandRouter::volumioGetState Sep 04 06:46:33 volumio volumio[3282]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 04 06:46:33 volumio volumio[3282]: info: Reading package lists... Sep 04 06:46:33 volumio volumio[3282]: info: Building dependency tree... Sep 04 06:46:33 volumio volumio[3282]: info: Reading state information... Sep 04 06:46:33 volumio volumio[3282]: info: All packages are up to date. Sep 04 06:46:33 volumio sudo[7874]: pam_unix(sudo:session): session closed for user root Sep 04 06:46:33 volumio sudo[8083]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Sep 04 06:46:33 volumio sudo[8083]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:46:33 volumio volumio[3282]: info: Reading package lists... Sep 04 06:46:34 volumio volumio[3282]: info: Building dependency tree... Sep 04 06:46:34 volumio volumio[3282]: info: Reading state information... Sep 04 06:46:34 volumio volumio[3282]: info: The following additional packages will be installed: Sep 04 06:46:34 volumio volumio[3282]: info: binutils binutils-common binutils-x86-64-linux-gnu build-essential bzip2 Sep 04 06:46:34 volumio volumio[3282]: info: dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8 libalgorithm-diff-perl Sep 04 06:46:34 volumio volumio[3282]: info: libalgorithm-diff-xs-perl libalgorithm-merge-perl libasan5 libbinutils Sep 04 06:46:34 volumio volumio[3282]: info: libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libitm1 liblsan0 libmpx2 Sep 04 06:46:34 volumio volumio[3282]: info: libpython3-dev libpython3.7 libpython3.7-dev libquadmath0 libstdc++-8-dev Sep 04 06:46:34 volumio volumio[3282]: info: libtsan0 libubsan1 make patch python-pip-whl python3-asn1crypto Sep 04 06:46:34 volumio volumio[3282]: info: python3-async-timeout python3-attr python3-cffi-backend python3-crypto Sep 04 06:46:34 volumio volumio[3282]: info: python3-cryptography python3-dbus python3-dev python3-entrypoints python3-gi Sep 04 06:46:34 volumio volumio[3282]: info: python3-keyring python3-keyrings.alt python3-multidict python3-secretstorage Sep 04 06:46:34 volumio volumio[3282]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Sep 04 06:46:34 volumio volumio[3282]: info: Suggested packages: Sep 04 06:46:34 volumio volumio[3282]: info: binutils-doc bzip2-doc debian-keyring g++-multilib g++-8-multilib gcc-8-doc Sep 04 06:46:34 volumio volumio[3282]: info: libstdc++6-8-dbg gcc-multilib autoconf automake libtool flex bison gdb Sep 04 06:46:34 volumio volumio[3282]: info: gcc-doc gcc-8-multilib gcc-8-locales libgcc1-dbg libgomp1-dbg libitm1-dbg Sep 04 06:46:34 volumio volumio[3282]: info: libatomic1-dbg libasan5-dbg liblsan0-dbg libtsan0-dbg libubsan1-dbg Sep 04 06:46:34 volumio volumio[3282]: info: libmpx2-dbg libquadmath0-dbg libstdc++-8-doc make-doc ed diffutils-doc Sep 04 06:46:34 volumio volumio[3282]: info: python-attr-doc python-crypto-doc python-cryptography-doc Sep 04 06:46:34 volumio volumio[3282]: info: python3-cryptography-vectors python-dbus-doc python3-dbus-dbg gnome-keyring Sep 04 06:46:34 volumio volumio[3282]: info: libkf5wallet-bin gir1.2-gnomekeyring-1.0 python-secretstorage-doc Sep 04 06:46:34 volumio volumio[3282]: info: python-setuptools-doc Sep 04 06:46:34 volumio volumio[3282]: info: The following NEW packages will be installed: Sep 04 06:46:34 volumio volumio[3282]: info: binutils binutils-common binutils-x86-64-linux-gnu build-essential bzip2 Sep 04 06:46:34 volumio volumio[3282]: info: dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8 libalgorithm-diff-perl Sep 04 06:46:34 volumio volumio[3282]: info: libalgorithm-diff-xs-perl libalgorithm-merge-perl libasan5 libbinutils Sep 04 06:46:34 volumio volumio[3282]: info: libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libitm1 liblsan0 libmpx2 Sep 04 06:46:34 volumio volumio[3282]: info: libpython3-dev libpython3.7 libpython3.7-dev libquadmath0 libstdc++-8-dev Sep 04 06:46:34 volumio volumio[3282]: info: libtsan0 libubsan1 make patch python-pip-whl python3-aiohttp Sep 04 06:46:34 volumio volumio[3282]: info: python3-asn1crypto python3-async-timeout python3-attr python3-cffi-backend Sep 04 06:46:34 volumio volumio[3282]: info: python3-crypto python3-cryptography python3-dbus python3-dev Sep 04 06:46:34 volumio volumio[3282]: info: python3-entrypoints python3-gi python3-keyring python3-keyrings.alt Sep 04 06:46:34 volumio volumio[3282]: info: python3-multidict python3-pip python3-secretstorage python3-setuptools Sep 04 06:46:34 volumio volumio[3282]: info: python3-wheel python3-xdg python3-yarl python3.7-dev Sep 04 06:46:34 volumio volumio[3282]: info: 0 upgraded, 55 newly installed, 0 to remove and 0 not upgraded. Sep 04 06:46:34 volumio volumio[3282]: info: Need to get 85.3 MB of archives. Sep 04 06:46:34 volumio volumio[3282]: info: After this operation, 227 MB of additional disk space will be used. Sep 04 06:46:34 volumio volumio[3282]: info: Get:1 http://deb.debian.org/debian buster/main amd64 bzip2 amd64 1.0.6-9.2~deb10u1 [48.4 kB] Sep 04 06:46:34 volumio volumio[3282]: info: Get:2 http://deb.debian.org/debian buster/main amd64 binutils-common amd64 2.31.1-16 [2073 kB] Sep 04 06:46:36 volumio volumio[3282]: info: Get:3 http://deb.debian.org/debian buster/main amd64 libbinutils amd64 2.31.1-16 [478 kB] Sep 04 06:46:36 volumio volumio[3282]: info: Get:4 http://deb.debian.org/debian buster/main amd64 binutils-x86-64-linux-gnu amd64 2.31.1-16 [1823 kB] Sep 04 06:46:36 volumio volumio-remote-updater[754]: [2024-09-04 06:46:36] [connect] Successful connection Sep 04 06:46:36 volumio volumio-remote-updater[754]: [2024-09-04 06:46:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725432396 101 Sep 04 06:46:36 volumio volumio[3282]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 10 Sep 04 06:46:37 volumio volumio[3282]: verbose: New Socket.io Connection to 10.10.3.14 from 10.10.2.184 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::volumioGetState Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::volumioGetState Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::volumioGetQueue Sep 04 06:46:37 volumio volumio[3282]: info: CoreStateMachine::getQueue Sep 04 06:46:37 volumio volumio[3282]: info: CorePlayQueue::getQueue Sep 04 06:46:37 volumio volumio[3282]: info: Listing playlists Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 06:46:37 volumio volumio[3282]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 04 06:46:37 volumio volumio[3282]: info: Received Get System Info Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 06:46:37 volumio volumio[3282]: info: Discovery: Getting this device information Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::volumioGetState Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::volumioGetState Sep 04 06:46:37 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 06:46:37 volumio volumio[3282]: info: Get:5 http://deb.debian.org/debian buster/main amd64 binutils amd64 2.31.1-16 [56.8 kB] Sep 04 06:46:37 volumio volumio[3282]: info: Get:6 http://deb.debian.org/debian buster/main amd64 libcc1-0 amd64 8.3.0-6 [46.6 kB] Sep 04 06:46:38 volumio volumio[3282]: info: Get:7 http://deb.debian.org/debian buster/main amd64 libitm1 amd64 8.3.0-6 [27.7 kB] Sep 04 06:46:38 volumio volumio[3282]: info: Get:8 http://deb.debian.org/debian buster/main amd64 libasan5 amd64 8.3.0-6 [362 kB] Sep 04 06:46:38 volumio volumio[3282]: info: Get:9 http://deb.debian.org/debian buster/main amd64 liblsan0 amd64 8.3.0-6 [131 kB] Sep 04 06:46:38 volumio volumio[3282]: info: Get:10 http://deb.debian.org/debian buster/main amd64 libtsan0 amd64 8.3.0-6 [283 kB] Sep 04 06:46:39 volumio volumio[3282]: info: Get:11 http://deb.debian.org/debian buster/main amd64 libubsan1 amd64 8.3.0-6 [120 kB] Sep 04 06:46:39 volumio volumio[3282]: info: Get:12 http://deb.debian.org/debian buster/main amd64 libmpx2 amd64 8.3.0-6 [11.4 kB] Sep 04 06:46:39 volumio volumio[3282]: info: Get:13 http://deb.debian.org/debian buster/main amd64 libquadmath0 amd64 8.3.0-6 [133 kB] Sep 04 06:46:39 volumio volumio[3282]: info: Get:14 http://deb.debian.org/debian buster/main amd64 libgcc-8-dev amd64 8.3.0-6 [2298 kB] Sep 04 06:46:40 volumio volumio[3282]: info: Get:15 http://deb.debian.org/debian buster/main amd64 gcc-8 amd64 8.3.0-6 [9452 kB] Sep 04 06:46:46 volumio volumio[3282]: info: Get:16 http://deb.debian.org/debian buster/main amd64 gcc amd64 4:8.3.0-1 [5196 B] Sep 04 06:46:46 volumio volumio[3282]: info: Get:17 http://deb.debian.org/debian buster/main amd64 libstdc++-8-dev amd64 8.3.0-6 [1532 kB] Sep 04 06:46:46 volumio volumio[3282]: info: Get:18 http://deb.debian.org/debian buster/main amd64 g++-8 amd64 8.3.0-6 [9752 kB] Sep 04 06:46:51 volumio volumio[3282]: info: Get:19 http://deb.debian.org/debian buster/main amd64 g++ amd64 4:8.3.0-1 [1644 B] Sep 04 06:46:51 volumio volumio[3282]: info: Get:20 http://deb.debian.org/debian buster/main amd64 make amd64 4.2.1-1.2 [341 kB] Sep 04 06:46:51 volumio volumio[3282]: info: Get:21 http://deb.debian.org/debian buster/main amd64 patch amd64 2.7.6-3+deb10u1 [126 kB] Sep 04 06:46:51 volumio volumio[3282]: info: Get:22 http://deb.debian.org/debian buster/main amd64 dpkg-dev all 1.19.8 [1776 kB] Sep 04 06:46:52 volumio volumio[3282]: info: Get:23 http://deb.debian.org/debian buster/main amd64 build-essential amd64 12.6 [7576 B] Sep 04 06:46:52 volumio volumio[3282]: info: Get:24 http://deb.debian.org/debian buster/main amd64 dh-python all 3.20190308 [99.3 kB] Sep 04 06:46:52 volumio volumio[3282]: info: Get:25 http://deb.debian.org/debian buster/main amd64 libfakeroot amd64 1.23-1 [45.9 kB] Sep 04 06:46:52 volumio volumio[3282]: info: Get:26 http://deb.debian.org/debian buster/main amd64 fakeroot amd64 1.23-1 [85.8 kB] Sep 04 06:46:52 volumio volumio[3282]: info: Get:27 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-perl all 1.19.03-2 [47.9 kB] Sep 04 06:46:53 volumio volumio[3282]: info: Get:28 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-xs-perl amd64 0.04-5+b1 [11.8 kB] Sep 04 06:46:53 volumio volumio[3282]: info: Get:29 http://deb.debian.org/debian buster/main amd64 libalgorithm-merge-perl all 0.08-3 [12.7 kB] Sep 04 06:46:53 volumio volumio[3282]: info: Get:30 http://deb.debian.org/debian buster/main amd64 libexpat1-dev amd64 2.2.6-2+deb10u4 [155 kB] Sep 04 06:46:53 volumio volumio[3282]: info: Get:31 http://deb.debian.org/debian buster/main amd64 libpython3.7 amd64 3.7.3-2+deb10u3 [1498 kB] Sep 04 06:46:53 volumio volumio[3282]: info: Get:32 http://deb.debian.org/debian buster/main amd64 libpython3.7-dev amd64 3.7.3-2+deb10u3 [48.4 MB] Sep 04 06:47:07 volumio volumio[3282]: info: Enabling plugin fusiondsp Sep 04 06:47:07 volumio volumio[3282]: info: Loading plugin "fusiondsp"... Sep 04 06:47:08 volumio volumio[3282]: info: Preparing to generate the ALSA configuration file Sep 04 06:47:09 volumio volumio[3282]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Sep 04 06:47:09 volumio volumio[3282]: info: Reading ALSA contributions from plugins. Sep 04 06:47:09 volumio volumio[3282]: info: Asound.conf file unchanged, so no further update is needed Sep 04 06:47:09 volumio volumio[3282]: info: Output device has changed, restarting MPD Sep 04 06:47:09 volumio sudo[8151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 06:47:09 volumio sudo[8151]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio sudo[8151]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: Output device has changed, restarting Shairport Sync Sep 04 06:47:09 volumio sudo[8155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:47:09 volumio sudo[8155]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio systemd[1]: Stopping Music Player Daemon... Sep 04 06:47:09 volumio systemd[1]: mpd.service: Succeeded. Sep 04 06:47:09 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 06:47:09 volumio volumio[3282]: No protocol specified Sep 04 06:47:09 volumio volumio[3282]: xcb_connection_has_error() returned true Sep 04 06:47:09 volumio volumio[3282]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 06:47:09 volumio volumio[3282]: No protocol specified Sep 04 06:47:09 volumio volumio[3282]: xcb_connection_has_error() returned true Sep 04 06:47:09 volumio volumio[3282]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio vtcs[4584]: [2024-09-04 06:47:09.150] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Sep 04 06:47:09 volumio vtcs[4584]: [2024-09-04 06:47:09.150] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Sep 04 06:47:09 volumio systemd[1]: Starting Music Player Daemon... Sep 04 06:47:09 volumio volumio[3282]: info: PLUGIN START: fusiondsp Sep 04 06:47:09 volumio volumio[3282]: info: Loading i18n strings for locale en Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: FusionDsp - mixtype--------------------- None Sep 04 06:47:09 volumio volumio[3282]: info: Preparing to generate the ALSA configuration file Sep 04 06:47:09 volumio volumio[3282]: info: Done. Sep 04 06:47:09 volumio volumio[3282]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Sep 04 06:47:09 volumio volumio[3282]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 04 06:47:09 volumio volumio[3282]: info: Reading ALSA contributions from plugins. Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 06:47:09 volumio volumio[3282]: info: MPD Permissions set Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio sudo[8166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 06:47:09 volumio sudo[8166]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio sudo[8169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 06:47:09 volumio sudo[8169]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Sep 04 06:47:09 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Sep 04 06:47:09 volumio systemd[1]: vtcs.service: Succeeded. Sep 04 06:47:09 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 04 06:47:09 volumio sudo[8166]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio sudo[8169]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio sudo[8162]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 06:47:09 volumio sudo[8162]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio sudo[8162]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio volumio[3282]: info: Starting Shairport Sync Sep 04 06:47:09 volumio sudo[8182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 06:47:09 volumio sudo[8182]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio volumio[3282]: info: Asound.conf file written Sep 04 06:47:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 06:47:09 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 06:47:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 06:47:09 volumio sudo[8185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 04 06:47:09 volumio sudo[8185]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 06:47:09 volumio sudo[8182]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio mpd[8180]: Sep 04 06:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 06:47:09 volumio systemd[1]: Started Music Player Daemon. Sep 04 06:47:09 volumio sudo[8155]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio sudo[8185]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: No protocol specified Sep 04 06:47:09 volumio volumio[3282]: xcb_connection_has_error() returned true Sep 04 06:47:09 volumio volumio[3282]: info: Output device has changed, restarting MPD Sep 04 06:47:09 volumio sudo[8196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 06:47:09 volumio sudo[8196]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio sudo[8196]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: Output device has changed, restarting Shairport Sync Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio sudo[8199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 06:47:09 volumio sudo[8199]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:47:09 volumio systemd[1]: Stopping Music Player Daemon... Sep 04 06:47:09 volumio systemd[1]: mpd.service: Succeeded. Sep 04 06:47:09 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 06:47:09 volumio volumio[3282]: No protocol specified Sep 04 06:47:09 volumio volumio[3282]: xcb_connection_has_error() returned true Sep 04 06:47:09 volumio volumio[3282]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 06:47:09 volumio volumio[3282]: No protocol specified Sep 04 06:47:09 volumio volumio[3282]: xcb_connection_has_error() returned true Sep 04 06:47:09 volumio volumio[3282]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio sudo[8208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 06:47:09 volumio systemd[1]: Starting Music Player Daemon... Sep 04 06:47:09 volumio sudo[8208]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio sudo[8211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 06:47:09 volumio sudo[8211]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 06:47:09 volumio sudo[8208]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: MPD Permissions set Sep 04 06:47:09 volumio volumio[3282]: info: Shairport-Sync Started Sep 04 06:47:09 volumio sudo[8211]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio sudo[8202]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 06:47:09 volumio sudo[8202]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio sudo[8202]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 04 06:47:09 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:09 volumio volumio[3282]: info: Starting Shairport Sync Sep 04 06:47:09 volumio sudo[8225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 06:47:09 volumio sudo[8225]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 06:47:09 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 06:47:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 06:47:09 volumio volumio[3282]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 06:47:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 06:47:09 volumio sudo[8225]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:09 volumio volumio[3282]: info: Shairport-Sync Started Sep 04 06:47:10 volumio mpd[8221]: Sep 04 06:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 06:47:10 volumio systemd[1]: Started Music Player Daemon. Sep 04 06:47:10 volumio sudo[8199]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:10 volumio volumio[3282]: error: updateQueue error: null Sep 04 06:47:10 volumio volumio[3282]: error: updateQueue error: null Sep 04 06:47:11 volumio volumio[3282]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Sep 04 06:47:11 volumio volumio[3282]: info: camilladsp service started and running in background, instance 1 Sep 04 06:47:11 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:47:11 volumio volumio[3282]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 06:47:11 volumio volumio[3282]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Sep 04 06:47:11 volumio volumio[3282]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 06:47:11 volumio volumio[3282]: info: FusionDsp loaded Sep 04 06:47:11 volumio volumio[3282]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 06:47:11 volumio sudo[8243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 04 06:47:11 volumio sudo[8243]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:47:11 volumio volumio[3282]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 04 06:47:11 volumio volumio[3282]: info: Adding Signal Path Element [object Object] Sep 04 06:47:11 volumio volumio[3282]: info: Adding fusiondspeq DSP Signal Path Element Sep 04 06:47:11 volumio volumio[3282]: info: FusionDsp - ---- installed callbackRead Sep 04 06:47:11 volumio volumio[3282]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 06:47:11 volumio volumio[3282]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Sep 04 06:47:11 volumio volumio[3282]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Sep 04 06:47:11 volumio volumio[3282]: at onErrorNT (internal/child_process.js:472:16) Sep 04 06:47:11 volumio volumio[3282]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Sep 04 06:47:11 volumio volumio[3282]: at runNextTicks (internal/process/task_queues.js:64:3) Sep 04 06:47:11 volumio volumio[3282]: at listOnTimeout (internal/timers.js:526:9) Sep 04 06:47:11 volumio volumio[3282]: at processTimers (internal/timers.js:500:7) { Sep 04 06:47:11 volumio volumio[3282]: errno: -2, Sep 04 06:47:11 volumio volumio[3282]: code: 'ENOENT', Sep 04 06:47:11 volumio volumio[3282]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 06:47:11 volumio volumio[3282]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 06:47:11 volumio volumio[3282]: spawnargs: [ Sep 04 06:47:11 volumio volumio[3282]: '-p', Sep 04 06:47:11 volumio volumio[3282]: 9876, Sep 04 06:47:11 volumio volumio[3282]: '-o', Sep 04 06:47:11 volumio volumio[3282]: '/tmp/camilladsp.log', Sep 04 06:47:11 volumio volumio[3282]: '-l', Sep 04 06:47:11 volumio volumio[3282]: 'warn', Sep 04 06:47:11 volumio volumio[3282]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 04 06:47:11 volumio volumio[3282]: ] Sep 04 06:47:11 volumio volumio[3282]: } Sep 04 06:47:11 volumio volumio[3282]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 06:47:11 volumio sudo[8243]: pam_unix(sudo:session): session closed for user root Sep 04 06:47:11 volumio sudo[8254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 06:46 Sep 04 06:47:11 volumio sudo[8254]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"