-- Logs begin at Tue 2024-08-20 17:33:09 +07, end at Tue 2024-08-20 18:06:51 +07. -- Aug 20 18:05:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:05:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:05:03 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:05:03 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:05:03 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:05:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:05:05 volumio volumio[962]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/amd64 Aug 20 18:05:08 volumio volumio[962]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/amd64 Aug 20 18:05:08 volumio volumio[962]: info: Folder /tmp/plugins removed Aug 20 18:05:09 volumio volumio[962]: info: Check plugin dependencies Aug 20 18:05:09 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 18:05:09 volumio volumio[962]: info: Checking if plugin already exists Aug 20 18:05:09 volumio volumio[962]: info: Rename folder Aug 20 18:05:09 volumio volumio[962]: info: Folder /tmp/downloaded_plugin.zip removed Aug 20 18:05:09 volumio volumio[962]: info: Move to category Aug 20 18:05:11 volumio volumio[962]: info: Checking if install.sh is present Aug 20 18:05:11 volumio volumio[962]: info: Executing install.sh Aug 20 18:05:11 volumio sudo[3868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/youtube2/install.sh Aug 20 18:05:11 volumio sudo[3868]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:05:11 volumio sudo[3868]: pam_unix(sudo:session): session closed for user root Aug 20 18:05:11 volumio volumio[962]: info: YouTube2 plugin installed Aug 20 18:05:11 volumio volumio[962]: Plugin install end detected on script Aug 20 18:05:11 volumio volumio[962]: info: Install script completed Aug 20 18:05:11 volumio volumio[962]: info: Adding reference to registry Aug 20 18:05:11 volumio volumio[962]: info: Done installing plugin. Aug 20 18:05:11 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 18:05:11 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 20 18:05:11 volumio volumio[962]: info: Folder /tmp/plugins removed Aug 20 18:05:11 volumio volumio[962]: info: Folder /tmp/downloaded_plugin.zip removed Aug 20 18:05:11 volumio volumio[962]: info: Folder /data/temp removed Aug 20 18:05:12 volumio volumio[962]: info: Enabling plugin youtube2 Aug 20 18:05:12 volumio volumio[962]: info: Loading plugin "youtube2"... Aug 20 18:05:14 volumio volumio[962]: info: PLUGIN START: youtube2 Aug 20 18:05:14 volumio volumio[962]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 18:05:14 volumio volumio[962]: info: [1724151914037] CoreMusicLibrary::Adding element YouTube2 Aug 20 18:05:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 18:05:14 volumio volumio[962]: Cannot find translation for source YouTube2 Aug 20 18:05:14 volumio volumio[962]: info: Done. Aug 20 18:05:15 volumio volumio[962]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Aug 20 18:05:18 volumio volumio[962]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Aug 20 18:05:18 volumio volumio[962]: info: Folder /tmp/plugins removed Aug 20 18:05:19 volumio volumio[962]: info: Check plugin dependencies Aug 20 18:05:19 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 18:05:19 volumio volumio[962]: info: Checking if plugin already exists Aug 20 18:05:19 volumio volumio[962]: info: Rename folder Aug 20 18:05:19 volumio volumio[962]: info: Folder /tmp/downloaded_plugin.zip removed Aug 20 18:05:19 volumio volumio[962]: info: Move to category Aug 20 18:05:19 volumio volumio[962]: info: Checking if install.sh is present Aug 20 18:05:19 volumio volumio[962]: info: Executing install.sh Aug 20 18:05:19 volumio sudo[3942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Aug 20 18:05:19 volumio sudo[3942]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:05:19 volumio volumio[962]: info: creating filters folder and copying demo filters Aug 20 18:05:19 volumio volumio[962]: info: copying demo flters Aug 20 18:05:19 volumio volumio[962]: info: Installing/fusiondsp dependencies Aug 20 18:05:19 volumio sudo[3963]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Aug 20 18:05:19 volumio sudo[3963]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:05:20 volumio volumio[962]: info: Hit:1 http://deb.debian.org/debian buster InRelease Aug 20 18:05:20 volumio volumio[962]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Aug 20 18:05:25 volumio volumio[962]: info: Reading package lists... Aug 20 18:05:26 volumio volumio[962]: info: Building dependency tree... Aug 20 18:05:26 volumio volumio[962]: info: Reading state information... Aug 20 18:05:26 volumio volumio[962]: info: All packages are up to date. Aug 20 18:05:26 volumio sudo[3963]: pam_unix(sudo:session): session closed for user root Aug 20 18:05:26 volumio sudo[4174]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Aug 20 18:05:26 volumio sudo[4174]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:05:26 volumio volumio[962]: info: Reading package lists... Aug 20 18:05:27 volumio volumio[962]: info: Building dependency tree... Aug 20 18:05:27 volumio volumio[962]: info: Reading state information... Aug 20 18:05:28 volumio volumio[962]: info: The following additional packages will be installed: Aug 20 18:05:28 volumio volumio[962]: info: binutils binutils-common binutils-x86-64-linux-gnu build-essential dh-python Aug 20 18:05:28 volumio volumio[962]: info: dpkg-dev fakeroot g++ g++-8 gcc gcc-8 libalgorithm-diff-perl Aug 20 18:05:28 volumio volumio[962]: info: libalgorithm-diff-xs-perl libalgorithm-merge-perl libasan5 libbinutils Aug 20 18:05:28 volumio volumio[962]: info: libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libitm1 liblsan0 libmpx2 Aug 20 18:05:28 volumio volumio[962]: info: libpython3-dev libpython3.7 libpython3.7-dev libquadmath0 libstdc++-8-dev Aug 20 18:05:28 volumio volumio[962]: info: libtsan0 libubsan1 make patch python-pip-whl python3-asn1crypto Aug 20 18:05:28 volumio volumio[962]: info: python3-async-timeout python3-attr python3-cffi-backend python3-crypto Aug 20 18:05:28 volumio volumio[962]: info: python3-cryptography python3-dbus python3-dev python3-entrypoints python3-gi Aug 20 18:05:28 volumio volumio[962]: info: python3-keyring python3-keyrings.alt python3-multidict python3-secretstorage Aug 20 18:05:28 volumio volumio[962]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Aug 20 18:05:28 volumio volumio[962]: info: Suggested packages: Aug 20 18:05:28 volumio volumio[962]: info: binutils-doc debian-keyring g++-multilib g++-8-multilib gcc-8-doc Aug 20 18:05:28 volumio volumio[962]: info: libstdc++6-8-dbg gcc-multilib autoconf automake libtool flex bison gdb Aug 20 18:05:28 volumio volumio[962]: info: gcc-doc gcc-8-multilib gcc-8-locales libgcc1-dbg libgomp1-dbg libitm1-dbg Aug 20 18:05:28 volumio volumio[962]: info: libatomic1-dbg libasan5-dbg liblsan0-dbg libtsan0-dbg libubsan1-dbg Aug 20 18:05:28 volumio volumio[962]: info: libmpx2-dbg libquadmath0-dbg libstdc++-8-doc make-doc ed diffutils-doc Aug 20 18:05:28 volumio volumio[962]: info: python-attr-doc python-crypto-doc python-cryptography-doc Aug 20 18:05:28 volumio volumio[962]: info: python3-cryptography-vectors python-dbus-doc python3-dbus-dbg gnome-keyring Aug 20 18:05:28 volumio volumio[962]: info: libkf5wallet-bin gir1.2-gnomekeyring-1.0 python-secretstorage-doc Aug 20 18:05:28 volumio volumio[962]: info: python-setuptools-doc Aug 20 18:05:28 volumio volumio[962]: info: The following NEW packages will be installed: Aug 20 18:05:28 volumio volumio[962]: info: binutils binutils-common binutils-x86-64-linux-gnu build-essential dh-python Aug 20 18:05:28 volumio volumio[962]: info: dpkg-dev fakeroot g++ g++-8 gcc gcc-8 libalgorithm-diff-perl Aug 20 18:05:28 volumio volumio[962]: info: libalgorithm-diff-xs-perl libalgorithm-merge-perl libasan5 libbinutils Aug 20 18:05:28 volumio volumio[962]: info: libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libitm1 liblsan0 libmpx2 Aug 20 18:05:28 volumio volumio[962]: info: libpython3-dev libpython3.7 libpython3.7-dev libquadmath0 libstdc++-8-dev Aug 20 18:05:28 volumio volumio[962]: info: libtsan0 libubsan1 make patch python-pip-whl python3-aiohttp Aug 20 18:05:28 volumio volumio[962]: info: python3-asn1crypto python3-async-timeout python3-attr python3-cffi-backend Aug 20 18:05:28 volumio volumio[962]: info: python3-crypto python3-cryptography python3-dbus python3-dev Aug 20 18:05:28 volumio volumio[962]: info: python3-entrypoints python3-gi python3-keyring python3-keyrings.alt Aug 20 18:05:28 volumio volumio[962]: info: python3-multidict python3-pip python3-secretstorage python3-setuptools Aug 20 18:05:28 volumio volumio[962]: info: python3-wheel python3-xdg python3-yarl python3.7-dev Aug 20 18:05:28 volumio volumio[962]: info: 0 upgraded, 54 newly installed, 0 to remove and 0 not upgraded. Aug 20 18:05:28 volumio volumio[962]: info: Need to get 85.3 MB of archives. Aug 20 18:05:28 volumio volumio[962]: info: After this operation, 227 MB of additional disk space will be used. Aug 20 18:05:28 volumio volumio[962]: info: Get:1 http://deb.debian.org/debian buster/main amd64 binutils-common amd64 2.31.1-16 [2073 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:2 http://deb.debian.org/debian buster/main amd64 libbinutils amd64 2.31.1-16 [478 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:3 http://deb.debian.org/debian buster/main amd64 binutils-x86-64-linux-gnu amd64 2.31.1-16 [1823 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:4 http://deb.debian.org/debian buster/main amd64 binutils amd64 2.31.1-16 [56.8 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:5 http://deb.debian.org/debian buster/main amd64 libcc1-0 amd64 8.3.0-6 [46.6 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:6 http://deb.debian.org/debian buster/main amd64 libitm1 amd64 8.3.0-6 [27.7 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:7 http://deb.debian.org/debian buster/main amd64 libasan5 amd64 8.3.0-6 [362 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:8 http://deb.debian.org/debian buster/main amd64 liblsan0 amd64 8.3.0-6 [131 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:9 http://deb.debian.org/debian buster/main amd64 libtsan0 amd64 8.3.0-6 [283 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:10 http://deb.debian.org/debian buster/main amd64 libubsan1 amd64 8.3.0-6 [120 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:11 http://deb.debian.org/debian buster/main amd64 libmpx2 amd64 8.3.0-6 [11.4 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:12 http://deb.debian.org/debian buster/main amd64 libquadmath0 amd64 8.3.0-6 [133 kB] Aug 20 18:05:29 volumio volumio[962]: info: Get:13 http://deb.debian.org/debian buster/main amd64 libgcc-8-dev amd64 8.3.0-6 [2298 kB] Aug 20 18:05:30 volumio volumio[962]: info: Get:14 http://deb.debian.org/debian buster/main amd64 gcc-8 amd64 8.3.0-6 [9452 kB] Aug 20 18:05:31 volumio volumio[962]: info: Get:15 http://deb.debian.org/debian buster/main amd64 gcc amd64 4:8.3.0-1 [5196 B] Aug 20 18:05:31 volumio volumio[962]: info: Get:16 http://deb.debian.org/debian buster/main amd64 libstdc++-8-dev amd64 8.3.0-6 [1532 kB] Aug 20 18:05:31 volumio volumio[962]: info: Get:17 http://deb.debian.org/debian buster/main amd64 g++-8 amd64 8.3.0-6 [9752 kB] Aug 20 18:05:33 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:05:33 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:05:33 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:05:33 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:05:33 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:05:33 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:05:33 volumio volumio[962]: info: Get:18 http://deb.debian.org/debian buster/main amd64 g++ amd64 4:8.3.0-1 [1644 B] Aug 20 18:05:33 volumio volumio[962]: info: Get:19 http://deb.debian.org/debian buster/main amd64 make amd64 4.2.1-1.2 [341 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:20 http://deb.debian.org/debian buster/main amd64 patch amd64 2.7.6-3+deb10u1 [126 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:21 http://deb.debian.org/debian buster/main amd64 dpkg-dev all 1.19.8 [1776 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:22 http://deb.debian.org/debian buster/main amd64 build-essential amd64 12.6 [7576 B] Aug 20 18:05:33 volumio volumio[962]: info: Get:23 http://deb.debian.org/debian buster/main amd64 dh-python all 3.20190308 [99.3 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:24 http://deb.debian.org/debian buster/main amd64 libfakeroot amd64 1.23-1 [45.9 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:25 http://deb.debian.org/debian buster/main amd64 fakeroot amd64 1.23-1 [85.8 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:26 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-perl all 1.19.03-2 [47.9 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:27 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-xs-perl amd64 0.04-5+b1 [11.8 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:28 http://deb.debian.org/debian buster/main amd64 libalgorithm-merge-perl all 0.08-3 [12.7 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:29 http://deb.debian.org/debian buster/main amd64 libexpat1-dev amd64 2.2.6-2+deb10u4 [155 kB] Aug 20 18:05:33 volumio volumio[962]: info: Get:30 http://deb.debian.org/debian buster/main amd64 libpython3.7 amd64 3.7.3-2+deb10u3 [1498 kB] Aug 20 18:05:34 volumio volumio[962]: info: Get:31 http://deb.debian.org/debian buster/main amd64 libpython3.7-dev amd64 3.7.3-2+deb10u3 [48.4 MB] Aug 20 18:05:44 volumio volumio[962]: info: Get:32 http://deb.debian.org/debian buster/main amd64 libpython3-dev amd64 3.7.3-1 [20.1 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:33 http://deb.debian.org/debian buster/main amd64 python-pip-whl all 18.1-5 [1591 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:34 http://deb.debian.org/debian buster/main amd64 python3-multidict amd64 4.5.2-1 [60.6 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:35 http://deb.debian.org/debian buster/main amd64 python3-yarl amd64 1.3.0-1 [48.3 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:36 http://deb.debian.org/debian buster/main amd64 python3-async-timeout all 3.0.1-1 [6292 B] Aug 20 18:05:44 volumio volumio[962]: info: Get:37 http://deb.debian.org/debian buster/main amd64 python3-attr all 18.2.0-1 [37.3 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:38 http://deb.debian.org/debian buster/main amd64 python3-aiohttp amd64 3.5.1-1+deb10u1 [261 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:39 http://deb.debian.org/debian buster/main amd64 python3-asn1crypto all 0.24.0-1 [78.2 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:40 http://deb.debian.org/debian buster/main amd64 python3-cffi-backend amd64 1.12.2-1 [79.7 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:41 http://deb.debian.org/debian buster/main amd64 python3-crypto amd64 2.6.1-9+b1 [263 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:42 http://deb.debian.org/debian buster/main amd64 python3-cryptography amd64 2.6.1-3+deb10u2 [219 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:43 http://deb.debian.org/debian buster/main amd64 python3-dbus amd64 1.2.8-3 [103 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:44 http://deb.debian.org/debian buster/main amd64 python3.7-dev amd64 3.7.3-2+deb10u3 [510 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:45 http://deb.debian.org/debian buster/main amd64 python3-dev amd64 3.7.3-1 [1264 B] Aug 20 18:05:44 volumio volumio[962]: info: Get:46 http://deb.debian.org/debian buster/main amd64 python3-entrypoints all 0.3-1 [5508 B] Aug 20 18:05:44 volumio volumio[962]: info: Get:47 http://deb.debian.org/debian buster/main amd64 python3-gi amd64 3.30.4-1 [180 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:48 http://deb.debian.org/debian buster/main amd64 python3-secretstorage all 2.3.1-2 [14.2 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:49 http://deb.debian.org/debian buster/main amd64 python3-keyring all 17.1.1-1 [43.1 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:50 http://deb.debian.org/debian buster/main amd64 python3-keyrings.alt all 3.1.1-1 [18.2 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:51 http://deb.debian.org/debian buster/main amd64 python3-pip all 18.1-5 [171 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:52 http://deb.debian.org/debian buster/main amd64 python3-setuptools all 40.8.0-1 [306 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:53 http://deb.debian.org/debian buster/main amd64 python3-wheel all 0.32.3-2 [19.4 kB] Aug 20 18:05:44 volumio volumio[962]: info: Get:54 http://deb.debian.org/debian buster/main amd64 python3-xdg all 0.25-5 [35.9 kB] Aug 20 18:05:46 volumio volumio[962]: info: Fetched 85.3 MB in 16s (5258 kB/s) Aug 20 18:05:46 volumio volumio[962]: info: Selecting previously unselected package binutils-common:amd64. Aug 20 18:05:46 volumio volumio[962]: [620B blob data] Aug 20 18:05:46 volumio volumio[962]: info: Preparing to unpack .../00-binutils-common_2.31.1-16_amd64.deb ... Aug 20 18:05:46 volumio volumio[962]: info: Unpacking binutils-common:amd64 (2.31.1-16) ... Aug 20 18:05:46 volumio volumio[962]: info: Selecting previously unselected package libbinutils:amd64. Aug 20 18:05:46 volumio volumio[962]: info: Preparing to unpack .../01-libbinutils_2.31.1-16_amd64.deb ... Aug 20 18:05:46 volumio volumio[962]: info: Unpacking libbinutils:amd64 (2.31.1-16) ... Aug 20 18:05:47 volumio volumio[962]: info: Selecting previously unselected package binutils-x86-64-linux-gnu. Aug 20 18:05:47 volumio volumio[962]: info: Preparing to unpack .../02-binutils-x86-64-linux-gnu_2.31.1-16_amd64.deb ... Aug 20 18:05:47 volumio volumio[962]: info: Unpacking binutils-x86-64-linux-gnu (2.31.1-16) ... Aug 20 18:05:49 volumio volumio[962]: info: Selecting previously unselected package binutils. Aug 20 18:05:49 volumio volumio[962]: info: Preparing to unpack .../03-binutils_2.31.1-16_amd64.deb ... Aug 20 18:05:49 volumio volumio[962]: info: Unpacking binutils (2.31.1-16) ... Aug 20 18:05:49 volumio volumio[962]: info: Selecting previously unselected package libcc1-0:amd64. Aug 20 18:05:49 volumio volumio[962]: info: Preparing to unpack .../04-libcc1-0_8.3.0-6_amd64.deb ... Aug 20 18:05:49 volumio volumio[962]: info: Unpacking libcc1-0:amd64 (8.3.0-6) ... Aug 20 18:05:49 volumio volumio[962]: info: Selecting previously unselected package libitm1:amd64. Aug 20 18:05:49 volumio volumio[962]: info: Preparing to unpack .../05-libitm1_8.3.0-6_amd64.deb ... Aug 20 18:05:49 volumio volumio[962]: info: Unpacking libitm1:amd64 (8.3.0-6) ... Aug 20 18:05:49 volumio volumio[962]: info: Selecting previously unselected package libasan5:amd64. Aug 20 18:05:49 volumio volumio[962]: info: Preparing to unpack .../06-libasan5_8.3.0-6_amd64.deb ... Aug 20 18:05:49 volumio volumio[962]: info: Unpacking libasan5:amd64 (8.3.0-6) ... Aug 20 18:05:49 volumio volumio[962]: info: Selecting previously unselected package liblsan0:amd64. Aug 20 18:05:49 volumio volumio[962]: info: Preparing to unpack .../07-liblsan0_8.3.0-6_amd64.deb ... Aug 20 18:05:49 volumio volumio[962]: info: Unpacking liblsan0:amd64 (8.3.0-6) ... Aug 20 18:05:49 volumio volumio[962]: info: Selecting previously unselected package libtsan0:amd64. Aug 20 18:05:49 volumio volumio[962]: info: Preparing to unpack .../08-libtsan0_8.3.0-6_amd64.deb ... Aug 20 18:05:49 volumio volumio[962]: info: Unpacking libtsan0:amd64 (8.3.0-6) ... Aug 20 18:05:50 volumio volumio[962]: info: Selecting previously unselected package libubsan1:amd64. Aug 20 18:05:50 volumio volumio[962]: info: Preparing to unpack .../09-libubsan1_8.3.0-6_amd64.deb ... Aug 20 18:05:50 volumio volumio[962]: info: Unpacking libubsan1:amd64 (8.3.0-6) ... Aug 20 18:05:50 volumio volumio[962]: info: Selecting previously unselected package libmpx2:amd64. Aug 20 18:05:50 volumio volumio[962]: info: Preparing to unpack .../10-libmpx2_8.3.0-6_amd64.deb ... Aug 20 18:05:50 volumio volumio[962]: info: Unpacking libmpx2:amd64 (8.3.0-6) ... Aug 20 18:05:50 volumio volumio[962]: info: Selecting previously unselected package libquadmath0:amd64. Aug 20 18:05:50 volumio volumio[962]: info: Preparing to unpack .../11-libquadmath0_8.3.0-6_amd64.deb ... Aug 20 18:05:50 volumio volumio[962]: info: Unpacking libquadmath0:amd64 (8.3.0-6) ... Aug 20 18:05:50 volumio volumio[962]: info: Selecting previously unselected package libgcc-8-dev:amd64. Aug 20 18:05:50 volumio volumio[962]: info: Preparing to unpack .../12-libgcc-8-dev_8.3.0-6_amd64.deb ... Aug 20 18:05:50 volumio volumio[962]: info: Unpacking libgcc-8-dev:amd64 (8.3.0-6) ... Aug 20 18:05:52 volumio volumio[962]: info: Selecting previously unselected package gcc-8. Aug 20 18:05:52 volumio volumio[962]: info: Preparing to unpack .../13-gcc-8_8.3.0-6_amd64.deb ... Aug 20 18:05:52 volumio volumio[962]: info: Unpacking gcc-8 (8.3.0-6) ... Aug 20 18:05:55 volumio volumio[962]: info: Selecting previously unselected package gcc. Aug 20 18:05:55 volumio volumio[962]: info: Preparing to unpack .../14-gcc_4%3a8.3.0-1_amd64.deb ... Aug 20 18:05:55 volumio volumio[962]: info: Unpacking gcc (4:8.3.0-1) ... Aug 20 18:05:55 volumio volumio[962]: info: Selecting previously unselected package libstdc++-8-dev:amd64. Aug 20 18:05:55 volumio volumio[962]: info: Preparing to unpack .../15-libstdc++-8-dev_8.3.0-6_amd64.deb ... Aug 20 18:05:55 volumio volumio[962]: info: Unpacking libstdc++-8-dev:amd64 (8.3.0-6) ... Aug 20 18:05:59 volumio volumio[962]: info: Selecting previously unselected package g++-8. Aug 20 18:05:59 volumio volumio[962]: info: Preparing to unpack .../16-g++-8_8.3.0-6_amd64.deb ... Aug 20 18:05:59 volumio volumio[962]: info: Unpacking g++-8 (8.3.0-6) ... Aug 20 18:06:01 volumio volumio[962]: info: Selecting previously unselected package g++. Aug 20 18:06:01 volumio volumio[962]: info: Preparing to unpack .../17-g++_4%3a8.3.0-1_amd64.deb ... Aug 20 18:06:01 volumio volumio[962]: info: Unpacking g++ (4:8.3.0-1) ... Aug 20 18:06:01 volumio volumio[962]: info: Selecting previously unselected package make. Aug 20 18:06:01 volumio volumio[962]: info: Preparing to unpack .../18-make_4.2.1-1.2_amd64.deb ... Aug 20 18:06:01 volumio volumio[962]: info: Unpacking make (4.2.1-1.2) ... Aug 20 18:06:02 volumio volumio[962]: info: Selecting previously unselected package patch. Aug 20 18:06:02 volumio volumio[962]: info: Preparing to unpack .../19-patch_2.7.6-3+deb10u1_amd64.deb ... Aug 20 18:06:02 volumio volumio[962]: info: Unpacking patch (2.7.6-3+deb10u1) ... Aug 20 18:06:02 volumio volumio[962]: info: Selecting previously unselected package dpkg-dev. Aug 20 18:06:02 volumio volumio[962]: info: Preparing to unpack .../20-dpkg-dev_1.19.8_all.deb ... Aug 20 18:06:02 volumio volumio[962]: info: Unpacking dpkg-dev (1.19.8) ... Aug 20 18:06:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:03 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:03 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:03 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:03 volumio volumio[962]: info: Selecting previously unselected package build-essential. Aug 20 18:06:03 volumio volumio[962]: info: Preparing to unpack .../21-build-essential_12.6_amd64.deb ... Aug 20 18:06:03 volumio volumio[962]: info: Unpacking build-essential (12.6) ... Aug 20 18:06:03 volumio volumio[962]: info: Selecting previously unselected package dh-python. Aug 20 18:06:03 volumio volumio[962]: info: Preparing to unpack .../22-dh-python_3.20190308_all.deb ... Aug 20 18:06:03 volumio volumio[962]: info: Unpacking dh-python (3.20190308) ... Aug 20 18:06:03 volumio volumio[962]: info: Selecting previously unselected package libfakeroot:amd64. Aug 20 18:06:03 volumio volumio[962]: info: Preparing to unpack .../23-libfakeroot_1.23-1_amd64.deb ... Aug 20 18:06:03 volumio volumio[962]: info: Unpacking libfakeroot:amd64 (1.23-1) ... Aug 20 18:06:03 volumio ntpd[1264]: Soliciting pool server 2a0c:b847:ffff:79::e53c Aug 20 18:06:03 volumio volumio[962]: info: Selecting previously unselected package fakeroot. Aug 20 18:06:03 volumio volumio[962]: info: Preparing to unpack .../24-fakeroot_1.23-1_amd64.deb ... Aug 20 18:06:03 volumio volumio[962]: info: Unpacking fakeroot (1.23-1) ... Aug 20 18:06:03 volumio volumio[962]: info: Selecting previously unselected package libalgorithm-diff-perl. Aug 20 18:06:03 volumio volumio[962]: info: Preparing to unpack .../25-libalgorithm-diff-perl_1.19.03-2_all.deb ... Aug 20 18:06:04 volumio volumio[962]: info: Unpacking libalgorithm-diff-perl (1.19.03-2) ... Aug 20 18:06:04 volumio volumio[962]: info: Selecting previously unselected package libalgorithm-diff-xs-perl. Aug 20 18:06:04 volumio volumio[962]: info: Preparing to unpack .../26-libalgorithm-diff-xs-perl_0.04-5+b1_amd64.deb ... Aug 20 18:06:04 volumio volumio[962]: info: Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ... Aug 20 18:06:04 volumio volumio[962]: info: Selecting previously unselected package libalgorithm-merge-perl. Aug 20 18:06:04 volumio volumio[962]: info: Preparing to unpack .../27-libalgorithm-merge-perl_0.08-3_all.deb ... Aug 20 18:06:04 volumio volumio[962]: info: Unpacking libalgorithm-merge-perl (0.08-3) ... Aug 20 18:06:04 volumio volumio[962]: info: Selecting previously unselected package libexpat1-dev:amd64. Aug 20 18:06:05 volumio volumio[962]: info: Preparing to unpack .../28-libexpat1-dev_2.2.6-2+deb10u4_amd64.deb ... Aug 20 18:06:05 volumio volumio[962]: info: Unpacking libexpat1-dev:amd64 (2.2.6-2+deb10u4) ... Aug 20 18:06:05 volumio volumio[962]: info: Selecting previously unselected package libpython3.7:amd64. Aug 20 18:06:05 volumio volumio[962]: info: Preparing to unpack .../29-libpython3.7_3.7.3-2+deb10u3_amd64.deb ... Aug 20 18:06:05 volumio volumio[962]: info: Unpacking libpython3.7:amd64 (3.7.3-2+deb10u3) ... Aug 20 18:06:05 volumio volumio[962]: info: Selecting previously unselected package libpython3.7-dev:amd64. Aug 20 18:06:05 volumio volumio[962]: info: Preparing to unpack .../30-libpython3.7-dev_3.7.3-2+deb10u3_amd64.deb ... Aug 20 18:06:05 volumio volumio[962]: info: Unpacking libpython3.7-dev:amd64 (3.7.3-2+deb10u3) ... Aug 20 18:06:14 volumio volumio[962]: verbose: New Socket.io Connection to 192.168.1.62:3000 from 192.168.1.234 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Aug 20 18:06:14 volumio volumio[962]: verbose: New Socket.io Connection to 192.168.1.62 from 192.168.1.234 UA: Mozilla/5.0 (Linux; Android 14; CPH2531 Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:14 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 18:06:14 volumio volumio[962]: info: Received Get System Info Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:14 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:14 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:14 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:14 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:14 volumio volumio[962]: info: Listing playlists Aug 20 18:06:15 volumio volumio[962]: info: Selecting previously unselected package libpython3-dev:amd64. Aug 20 18:06:15 volumio volumio[962]: info: Preparing to unpack .../31-libpython3-dev_3.7.3-1_amd64.deb ... Aug 20 18:06:15 volumio volumio[962]: info: Unpacking libpython3-dev:amd64 (3.7.3-1) ... Aug 20 18:06:15 volumio volumio[962]: info: Selecting previously unselected package python-pip-whl. Aug 20 18:06:15 volumio volumio[962]: info: Preparing to unpack .../32-python-pip-whl_18.1-5_all.deb ... Aug 20 18:06:15 volumio volumio[962]: info: Unpacking python-pip-whl (18.1-5) ... Aug 20 18:06:15 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:15 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:15 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:15 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:15 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:15 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:15 volumio volumio[962]: info: Selecting previously unselected package python3-multidict. Aug 20 18:06:15 volumio volumio[962]: info: Preparing to unpack .../33-python3-multidict_4.5.2-1_amd64.deb ... Aug 20 18:06:15 volumio volumio[962]: info: Unpacking python3-multidict (4.5.2-1) ... Aug 20 18:06:16 volumio volumio[962]: info: Selecting previously unselected package python3-yarl. Aug 20 18:06:16 volumio volumio[962]: info: Preparing to unpack .../34-python3-yarl_1.3.0-1_amd64.deb ... Aug 20 18:06:16 volumio volumio[962]: info: Unpacking python3-yarl (1.3.0-1) ... Aug 20 18:06:16 volumio volumio[962]: info: Selecting previously unselected package python3-async-timeout. Aug 20 18:06:16 volumio volumio[962]: info: Preparing to unpack .../35-python3-async-timeout_3.0.1-1_all.deb ... Aug 20 18:06:16 volumio volumio[962]: info: Unpacking python3-async-timeout (3.0.1-1) ... Aug 20 18:06:16 volumio volumio[962]: info: Selecting previously unselected package python3-attr. Aug 20 18:06:16 volumio volumio[962]: info: Preparing to unpack .../36-python3-attr_18.2.0-1_all.deb ... Aug 20 18:06:16 volumio volumio[962]: info: Unpacking python3-attr (18.2.0-1) ... Aug 20 18:06:16 volumio volumio[962]: info: Selecting previously unselected package python3-aiohttp. Aug 20 18:06:16 volumio volumio[962]: info: Preparing to unpack .../37-python3-aiohttp_3.5.1-1+deb10u1_amd64.deb ... Aug 20 18:06:16 volumio volumio[962]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Aug 20 18:06:17 volumio volumio[962]: info: Selecting previously unselected package python3-asn1crypto. Aug 20 18:06:17 volumio volumio[962]: info: Preparing to unpack .../38-python3-asn1crypto_0.24.0-1_all.deb ... Aug 20 18:06:17 volumio volumio[962]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Aug 20 18:06:17 volumio volumio[962]: info: Selecting previously unselected package python3-cffi-backend. Aug 20 18:06:17 volumio volumio[962]: info: Preparing to unpack .../39-python3-cffi-backend_1.12.2-1_amd64.deb ... Aug 20 18:06:17 volumio volumio[962]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Aug 20 18:06:17 volumio volumio[962]: info: Selecting previously unselected package python3-crypto. Aug 20 18:06:17 volumio volumio[962]: info: Preparing to unpack .../40-python3-crypto_2.6.1-9+b1_amd64.deb ... Aug 20 18:06:17 volumio volumio[962]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Aug 20 18:06:17 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 20 18:06:18 volumio volumio[962]: info: Selecting previously unselected package python3-cryptography. Aug 20 18:06:18 volumio volumio[962]: info: Preparing to unpack .../41-python3-cryptography_2.6.1-3+deb10u2_amd64.deb ... Aug 20 18:06:18 volumio volumio[962]: info: Unpacking python3-cryptography (2.6.1-3+deb10u2) ... Aug 20 18:06:18 volumio volumio[962]: info: Selecting previously unselected package python3-dbus. Aug 20 18:06:18 volumio volumio[962]: info: Preparing to unpack .../42-python3-dbus_1.2.8-3_amd64.deb ... Aug 20 18:06:18 volumio volumio[962]: info: Unpacking python3-dbus (1.2.8-3) ... Aug 20 18:06:19 volumio volumio[962]: info: Selecting previously unselected package python3.7-dev. Aug 20 18:06:19 volumio volumio[962]: info: Preparing to unpack .../43-python3.7-dev_3.7.3-2+deb10u3_amd64.deb ... Aug 20 18:06:19 volumio volumio[962]: info: Unpacking python3.7-dev (3.7.3-2+deb10u3) ... Aug 20 18:06:19 volumio volumio[962]: info: Selecting previously unselected package python3-dev. Aug 20 18:06:19 volumio volumio[962]: info: Preparing to unpack .../44-python3-dev_3.7.3-1_amd64.deb ... Aug 20 18:06:19 volumio volumio[962]: info: Unpacking python3-dev (3.7.3-1) ... Aug 20 18:06:19 volumio volumio[962]: info: Selecting previously unselected package python3-entrypoints. Aug 20 18:06:19 volumio volumio[962]: info: Preparing to unpack .../45-python3-entrypoints_0.3-1_all.deb ... Aug 20 18:06:19 volumio volumio[962]: info: Unpacking python3-entrypoints (0.3-1) ... Aug 20 18:06:19 volumio volumio[962]: info: Selecting previously unselected package python3-gi. Aug 20 18:06:19 volumio volumio[962]: info: Preparing to unpack .../46-python3-gi_3.30.4-1_amd64.deb ... Aug 20 18:06:19 volumio volumio[962]: info: Unpacking python3-gi (3.30.4-1) ... Aug 20 18:06:20 volumio volumio[962]: info: Selecting previously unselected package python3-secretstorage. Aug 20 18:06:20 volumio volumio[962]: info: Preparing to unpack .../47-python3-secretstorage_2.3.1-2_all.deb ... Aug 20 18:06:20 volumio volumio[962]: info: Unpacking python3-secretstorage (2.3.1-2) ... Aug 20 18:06:20 volumio volumio[962]: info: Selecting previously unselected package python3-keyring. Aug 20 18:06:20 volumio volumio[962]: info: Preparing to unpack .../48-python3-keyring_17.1.1-1_all.deb ... Aug 20 18:06:20 volumio volumio[962]: info: Unpacking python3-keyring (17.1.1-1) ... Aug 20 18:06:20 volumio volumio[962]: info: Selecting previously unselected package python3-keyrings.alt. Aug 20 18:06:20 volumio volumio[962]: info: Preparing to unpack .../49-python3-keyrings.alt_3.1.1-1_all.deb ... Aug 20 18:06:20 volumio volumio[962]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Aug 20 18:06:20 volumio volumio[962]: info: Selecting previously unselected package python3-pip. Aug 20 18:06:20 volumio volumio[962]: info: Preparing to unpack .../50-python3-pip_18.1-5_all.deb ... Aug 20 18:06:20 volumio volumio[962]: info: Unpacking python3-pip (18.1-5) ... Aug 20 18:06:21 volumio volumio[962]: info: Selecting previously unselected package python3-setuptools. Aug 20 18:06:21 volumio volumio[962]: info: Preparing to unpack .../51-python3-setuptools_40.8.0-1_all.deb ... Aug 20 18:06:21 volumio volumio[962]: info: Unpacking python3-setuptools (40.8.0-1) ... Aug 20 18:06:21 volumio volumio[962]: info: Selecting previously unselected package python3-wheel. Aug 20 18:06:21 volumio volumio[962]: info: Preparing to unpack .../52-python3-wheel_0.32.3-2_all.deb ... Aug 20 18:06:21 volumio volumio[962]: info: Unpacking python3-wheel (0.32.3-2) ... Aug 20 18:06:22 volumio volumio[962]: info: Selecting previously unselected package python3-xdg. Aug 20 18:06:22 volumio volumio[962]: info: Preparing to unpack .../53-python3-xdg_0.25-5_all.deb ... Aug 20 18:06:22 volumio volumio[962]: info: Unpacking python3-xdg (0.25-5) ... Aug 20 18:06:22 volumio volumio[962]: info: Setting up python3-entrypoints (0.3-1) ... Aug 20 18:06:22 volumio sudo[4737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 18:06:22 volumio sudo[4735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 18:06:22 volumio sudo[4735]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:22 volumio sudo[4737]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:22 volumio sudo[4735]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:22 volumio sudo[4737]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:22 volumio volumio[962]: verbose: New Socket.io Connection to 192.168.1.62 from 192.168.1.234 UA: Mozilla/5.0 (Linux; Android 14; CPH2531 Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 20 18:06:22 volumio sudo[4747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 18:06:22 volumio sudo[4747]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:22 volumio sudo[4747]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:22 volumio sudo[4750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 18:06:22 volumio sudo[4750]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:22 volumio sudo[4750]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:22 volumio volumio[962]: verbose: New Socket.io Connection to 192.168.1.62 from 192.168.1.234 UA: Mozilla/5.0 (Linux; Android 14; CPH2531 Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:23 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 18:06:23 volumio volumio[962]: info: Received Get System Info Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:23 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:23 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:23 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:23 volumio volumio[962]: info: Listing playlists Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 18:06:23 volumio volumio[962]: info: Setting up dh-python (3.20190308) ... Aug 20 18:06:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 18:06:23 volumio volumio[962]: info: Setting up python3-attr (18.2.0-1) ... Aug 20 18:06:24 volumio volumio[962]: info: Setting up python3-dbus (1.2.8-3) ... Aug 20 18:06:24 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 20 18:06:24 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 18:06:24 volumio volumio[962]: info: Received Get System Info Aug 20 18:06:24 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:24 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:24 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:24 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:24 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:24 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:24 volumio volumio[962]: info: Setting up python3-setuptools (40.8.0-1) ... Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Aug 20 18:06:25 volumio volumio[962]: info: Received Get System Version Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 18:06:25 volumio volumio[962]: info: Received Get System Info Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:25 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:25 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:25 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:25 volumio volumio[962]: info: Setting up libpython3.7:amd64 (3.7.3-2+deb10u3) ... Aug 20 18:06:25 volumio volumio[962]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Aug 20 18:06:25 volumio volumio[962]: info: Setting up binutils-common:amd64 (2.31.1-16) ... Aug 20 18:06:25 volumio volumio[962]: info: Setting up python3-xdg (0.25-5) ... Aug 20 18:06:26 volumio volumio[962]: info: Setting up python3-wheel (0.32.3-2) ... Aug 20 18:06:27 volumio volumio[962]: info: Setting up python3-multidict (4.5.2-1) ... Aug 20 18:06:27 volumio volumio[962]: info: Setting up libfakeroot:amd64 (1.23-1) ... Aug 20 18:06:27 volumio volumio[962]: info: Setting up python3-async-timeout (3.0.1-1) ... Aug 20 18:06:28 volumio volumio[962]: info: Setting up fakeroot (1.23-1) ... Aug 20 18:06:28 volumio volumio[962]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Aug 20 18:06:28 volumio volumio[962]: 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 20 18:06:28 volumio volumio[962]: 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 20 18:06:28 volumio volumio[962]: 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 20 18:06:28 volumio volumio[962]: 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 20 18:06:28 volumio volumio[962]: 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 20 18:06:28 volumio volumio[962]: 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 20 18:06:28 volumio volumio[962]: info: Setting up libasan5:amd64 (8.3.0-6) ... Aug 20 18:06:28 volumio volumio[962]: info: Setting up libexpat1-dev:amd64 (2.2.6-2+deb10u4) ... Aug 20 18:06:28 volumio volumio[962]: info: Setting up make (4.2.1-1.2) ... Aug 20 18:06:28 volumio volumio[962]: info: Setting up python3-gi (3.30.4-1) ... Aug 20 18:06:28 volumio volumio[962]: info: Setting up libquadmath0:amd64 (8.3.0-6) ... Aug 20 18:06:29 volumio volumio[962]: info: Setting up patch (2.7.6-3+deb10u1) ... Aug 20 18:06:29 volumio volumio[962]: info: Setting up libmpx2:amd64 (8.3.0-6) ... Aug 20 18:06:29 volumio volumio[962]: info: Setting up libubsan1:amd64 (8.3.0-6) ... Aug 20 18:06:29 volumio volumio[962]: info: Setting up python3-crypto (2.6.1-9+b1) ... Aug 20 18:06:29 volumio volumio[962]: info: Setting up python-pip-whl (18.1-5) ... Aug 20 18:06:30 volumio volumio[962]: info: Setting up libbinutils:amd64 (2.31.1-16) ... Aug 20 18:06:30 volumio volumio[962]: info: Setting up python3-yarl (1.3.0-1) ... Aug 20 18:06:30 volumio volumio[962]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Aug 20 18:06:30 volumio volumio[962]: info: Setting up python3-asn1crypto (0.24.0-1) ... Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 20 18:06:31 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 20 18:06:31 volumio volumio[962]: info: Setting up libcc1-0:amd64 (8.3.0-6) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up liblsan0:amd64 (8.3.0-6) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up libitm1:amd64 (8.3.0-6) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up python3-cffi-backend (1.12.2-1) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up binutils-x86-64-linux-gnu (2.31.1-16) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up libtsan0:amd64 (8.3.0-6) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up libpython3.7-dev:amd64 (3.7.3-2+deb10u3) ... Aug 20 18:06:31 volumio volumio[962]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Aug 20 18:06:32 volumio volumio[962]: info: Setting up binutils (2.31.1-16) ... Aug 20 18:06:32 volumio volumio[962]: info: Setting up python3.7-dev (3.7.3-2+deb10u3) ... Aug 20 18:06:32 volumio volumio[962]: info: Setting up dpkg-dev (1.19.8) ... Aug 20 18:06:32 volumio volumio[962]: info: Setting up python3-cryptography (2.6.1-3+deb10u2) ... Aug 20 18:06:32 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 20 18:06:33 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:33 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:33 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:33 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:33 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:33 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:33 volumio volumio[962]: info: Setting up python3-pip (18.1-5) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up libgcc-8-dev:amd64 (8.3.0-6) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up libstdc++-8-dev:amd64 (8.3.0-6) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up gcc-8 (8.3.0-6) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up libpython3-dev:amd64 (3.7.3-1) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up gcc (4:8.3.0-1) ... Aug 20 18:06:34 volumio volumio[962]: info: Setting up python3-secretstorage (2.3.1-2) ... Aug 20 18:06:35 volumio volumio[962]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 20 18:06:35 volumio volumio[962]: info: Preparing to save Alsa Options, stopping services first Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:35 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::volumioPause Aug 20 18:06:35 volumio volumio[962]: info: CoreStateMachine::pause Aug 20 18:06:35 volumio volumio[962]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"E30 II"}} Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 18:06:35 volumio volumio[962]: info: Setting mixer E30 II for card E30 II Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 20 18:06:35 volumio volumio[962]: info: Updating Volume Controller Parameters: Device: 5 Name: E30 II Mixer: E30 II Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 20 18:06:35 volumio volumio[962]: info: Disabling external Volume Control Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 18:06:35 volumio volumio[962]: info: Preparing to generate the ALSA configuration file Aug 20 18:06:35 volumio volumio[962]: info: Setting up python3-dev (3.7.3-1) ... Aug 20 18:06:35 volumio volumio[962]: info: Setting up g++-8 (8.3.0-6) ... Aug 20 18:06:35 volumio volumio[962]: info: Setting up python3-keyring (17.1.1-1) ... Aug 20 18:06:35 volumio volumio[962]: info: VolumeController:: Volume=100 Mute =false Aug 20 18:06:35 volumio volumio[962]: info: CoreStateMachine::pushState Aug 20 18:06:35 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 20 18:06:35 volumio volumio[962]: info: Asound.conf file written Aug 20 18:06:35 volumio sudo[5019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 20 18:06:35 volumio sudo[5019]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:35 volumio sudo[5019]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:35 volumio volumio[962]: info: Output device has changed, restarting MPD Aug 20 18:06:35 volumio sudo[5026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 18:06:35 volumio sudo[5026]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:35 volumio volumio[962]: info: Output device has changed, restarting Shairport Sync Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:35 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:35 volumio sudo[5026]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:35 volumio sudo[5029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 18:06:35 volumio sudo[5029]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:35 volumio systemd[1]: Stopping Music Player Daemon... Aug 20 18:06:35 volumio volumio[962]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 18:06:35 volumio volumio[962]: info: Output device has changed, restarting MPD Aug 20 18:06:36 volumio sudo[5036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 18:06:36 volumio sudo[5036]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:36 volumio volumio[962]: info: Output device has changed, restarting Shairport Sync Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:36 volumio sudo[5036]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:36 volumio sudo[5038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 18:06:36 volumio sudo[5038]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:36 volumio volumio[962]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 18:06:36 volumio volumio[962]: info: MPD Permissions set Aug 20 18:06:36 volumio volumio[962]: info: MPD Permissions set Aug 20 18:06:36 volumio volumio[962]: info: Setting up g++ (4:8.3.0-1) ... Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio systemd[1]: mpd.service: Succeeded. Aug 20 18:06:36 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 20 18:06:36 volumio systemd[1]: Starting Music Player Daemon... Aug 20 18:06:36 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:36 volumio volumio[962]: info: Starting Shairport Sync Aug 20 18:06:36 volumio volumio[962]: info: Starting Shairport Sync Aug 20 18:06:36 volumio sudo[5069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 18:06:36 volumio sudo[5069]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:36 volumio volumio[962]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Aug 20 18:06:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 18:06:36 volumio sudo[5055]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 18:06:36 volumio sudo[5055]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:36 volumio sudo[5073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 18:06:36 volumio sudo[5073]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:36 volumio sudo[5055]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:36 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 18:06:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:36 volumio volumio[962]: info: Setting up build-essential (12.6) ... Aug 20 18:06:36 volumio volumio[962]: info: Processing triggers for man-db (2.8.5-2) ... Aug 20 18:06:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:36 volumio sudo[5069]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:36 volumio volumio[962]: info: Shairport-Sync Started Aug 20 18:06:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 18:06:36 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 20 18:06:36 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 18:06:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:36 volumio sudo[5073]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:36 volumio volumio[962]: info: Shairport-Sync Started Aug 20 18:06:37 volumio mpd[5079]: Aug 20 18:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 20 18:06:37 volumio systemd[1]: Started Music Player Daemon. Aug 20 18:06:37 volumio sudo[5038]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:37 volumio sudo[5029]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:37 volumio volumio[962]: error: MPD error: The expression evaluated to a falsy value: Aug 20 18:06:37 volumio volumio[962]: assert.ok(self.idling) Aug 20 18:06:37 volumio volumio[962]: error: The expression evaluated to a falsy value: Aug 20 18:06:37 volumio volumio[962]: assert.ok(self.idling) Aug 20 18:06:37 volumio volumio[962]: error: updateQueue error: null Aug 20 18:06:38 volumio volumio[962]: info: Processing triggers for libc-bin (2.28-10+deb10u1) ... Aug 20 18:06:39 volumio volumio[962]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 20 18:06:39 volumio volumio[962]: info: CoreStateMachine::getcurrentVolume Aug 20 18:06:39 volumio volumio[962]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 18:06:39 volumio volumio[962]: info: VolumeController:: Volume=100 Mute =false Aug 20 18:06:39 volumio volumio[962]: info: CoreStateMachine::pushState Aug 20 18:06:39 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:39 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Aug 20 18:06:39 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Aug 20 18:06:39 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Aug 20 18:06:39 volumio volumio[962]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 18:06:39 volumio volumio[962]: info: VolumeController:: Volume=100 Mute =false Aug 20 18:06:39 volumio volumio[962]: info: CoreStateMachine::pushState Aug 20 18:06:39 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:39 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Aug 20 18:06:40 volumio sudo[4174]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:40 volumio sudo[5422]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Aug 20 18:06:40 volumio sudo[5422]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:40 volumio volumio[962]: info: lib/systemd/system/fusiondsp.service Aug 20 18:06:40 volumio sudo[5422]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 18:06:41 volumio volumio[962]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 20 18:06:41 volumio volumio[962]: info: Received Get System Version Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 18:06:41 volumio volumio[962]: info: Received Get System Info Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 18:06:41 volumio volumio[962]: info: Discovery: Getting this device information Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Aug 20 18:06:41 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Aug 20 18:06:41 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:44 volumio volumio[962]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Aug 20 18:06:44 volumio sudo[5426]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Aug 20 18:06:44 volumio sudo[5426]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:44 volumio volumio[962]: info: more info at http://www.winimage.com/zLibDll/unzip.html Aug 20 18:06:44 volumio volumio[962]: info: Aug 20 18:06:44 volumio volumio[962]: info: cgui-1.0.0.zip opened Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/ Aug 20 18:06:44 volumio sudo[5426]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/LICENSE.txt Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/README.md Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/build/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/robots.txt Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/logo512.png Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/asset-manifest.json Aug 20 18:06:44 volumio sudo[5428]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Aug 20 18:06:44 volumio sudo[5428]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/index.html Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/.put_statics_here Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/favicon.ico Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/logo192.png Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/manifest.json Aug 20 18:06:44 volumio sudo[5428]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/css-variables.css Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/service-worker.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/build/static/ Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/build/static/css/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Aug 20 18:06:44 volumio sudo[5430]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Aug 20 18:06:44 volumio sudo[5430]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/main.1503f6cd.css Aug 20 18:06:44 volumio sudo[5430]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/build/static/media/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/build/static/js/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.71e11955.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.71e11955.js.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/config/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/config/camillagui.yml Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/config/gui-config.yml Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/backend/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/filters_test.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/version.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/filters.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/settings.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/views.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/filterdefaults.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__init__.py Aug 20 18:06:44 volumio volumio[962]: info: creating directory: cgui/backend/__pycache__/ Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/routes.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/backend/filemanagement.py Aug 20 18:06:44 volumio volumio[962]: info: extracting: cgui/main.py Aug 20 18:06:45 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 18:06:45 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 20 18:06:48 volumio volumio[962]: info: Enabling plugin fusiondsp Aug 20 18:06:48 volumio volumio[962]: info: Loading plugin "fusiondsp"... Aug 20 18:06:48 volumio volumio[962]: info: Preparing to generate the ALSA configuration file Aug 20 18:06:48 volumio volumio[962]: info: Asound.conf file unchanged, so no further update is needed Aug 20 18:06:48 volumio volumio[962]: info: Output device has changed, restarting MPD Aug 20 18:06:48 volumio sudo[5434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 18:06:48 volumio volumio[962]: info: Output device has changed, restarting Shairport Sync Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:48 volumio sudo[5434]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:48 volumio sudo[5436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 18:06:48 volumio sudo[5436]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:48 volumio sudo[5434]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:48 volumio systemd[1]: Stopping Music Player Daemon... Aug 20 18:06:48 volumio volumio[962]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 18:06:48 volumio volumio[962]: info: PLUGIN START: fusiondsp Aug 20 18:06:48 volumio volumio[962]: info: Loading i18n strings for locale vi Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: FusionDsp - mixtype--------------------- Hardware Aug 20 18:06:48 volumio volumio[962]: info: Preparing to generate the ALSA configuration file Aug 20 18:06:48 volumio systemd[1]: mpd.service: Succeeded. Aug 20 18:06:48 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 18:06:48 volumio volumio[962]: info: Done. Aug 20 18:06:48 volumio volumio[962]: info: MPD Permissions set Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio systemd[1]: Starting Music Player Daemon... Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: Asound.conf file unchanged, so no further update is needed Aug 20 18:06:48 volumio volumio[962]: info: Output device has changed, restarting MPD Aug 20 18:06:48 volumio sudo[5451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 18:06:48 volumio sudo[5443]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 18:06:48 volumio sudo[5451]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:48 volumio sudo[5443]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:48 volumio volumio[962]: info: Output device has changed, restarting Shairport Sync Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:48 volumio sudo[5443]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:48 volumio sudo[5451]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:48 volumio sudo[5454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 18:06:48 volumio sudo[5454]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:48 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 20 18:06:48 volumio systemd[1]: mpd.service: Succeeded. Aug 20 18:06:48 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 18:06:48 volumio systemd[1]: Starting Music Player Daemon... Aug 20 18:06:48 volumio volumio[962]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 18:06:48 volumio volumio[962]: info: MPD Permissions set Aug 20 18:06:48 volumio volumio[962]: info: Starting Shairport Sync Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:48 volumio sudo[5466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 18:06:48 volumio sudo[5466]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:49 volumio sudo[5462]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 18:06:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 18:06:49 volumio sudo[5462]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:49 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 18:06:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:49 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 18:06:49 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 20 18:06:49 volumio sudo[5462]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:49 volumio sudo[5466]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:49 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:49 volumio volumio[962]: info: Shairport-Sync Started Aug 20 18:06:49 volumio volumio[962]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Aug 20 18:06:49 volumio volumio[962]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-hqsb0se9 Aug 20 18:06:49 volumio volumio[962]: info: Starting Shairport Sync Aug 20 18:06:49 volumio sudo[5483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 18:06:49 volumio sudo[5483]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 18:06:49 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 18:06:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 18:06:49 volumio sudo[5483]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:49 volumio volumio[962]: info: Shairport-Sync Started Aug 20 18:06:50 volumio mpd[5477]: Aug 20 18:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 20 18:06:50 volumio systemd[1]: Started Music Player Daemon. Aug 20 18:06:50 volumio sudo[5454]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:50 volumio sudo[5436]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:50 volumio volumio[962]: error: MPD error: The expression evaluated to a falsy value: Aug 20 18:06:50 volumio volumio[962]: assert.ok(self.idling) Aug 20 18:06:50 volumio volumio[962]: error: The expression evaluated to a falsy value: Aug 20 18:06:50 volumio volumio[962]: assert.ok(self.idling) Aug 20 18:06:50 volumio volumio[962]: error: updateQueue error: null Aug 20 18:06:50 volumio volumio[962]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 20 18:06:50 volumio volumio[962]: info: camilladsp service started and running in background, instance 1 Aug 20 18:06:50 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 18:06:50 volumio volumio[962]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 20 18:06:50 volumio volumio[962]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 20 18:06:50 volumio volumio[962]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 20 18:06:50 volumio volumio[962]: info: FusionDsp loaded Aug 20 18:06:50 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 18:06:50 volumio sudo[5503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 20 18:06:50 volumio sudo[5503]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 18:06:50 volumio volumio[962]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 20 18:06:50 volumio volumio[962]: info: Adding Signal Path Element [object Object] Aug 20 18:06:50 volumio volumio[962]: info: Adding fusiondspeq DSP Signal Path Element Aug 20 18:06:50 volumio volumio[962]: info: FusionDsp - ---- installed callbackRead Aug 20 18:06:50 volumio volumio[962]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 18:06:50 volumio volumio[962]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 20 18:06:50 volumio volumio[962]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 20 18:06:50 volumio volumio[962]: at onErrorNT (internal/child_process.js:472:16) Aug 20 18:06:50 volumio volumio[962]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Aug 20 18:06:50 volumio volumio[962]: errno: -2, Aug 20 18:06:50 volumio volumio[962]: code: 'ENOENT', Aug 20 18:06:50 volumio volumio[962]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 20 18:06:50 volumio volumio[962]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 20 18:06:50 volumio volumio[962]: spawnargs: [ Aug 20 18:06:50 volumio volumio[962]: '-p', Aug 20 18:06:50 volumio volumio[962]: 9876, Aug 20 18:06:50 volumio volumio[962]: '-o', Aug 20 18:06:50 volumio volumio[962]: '/tmp/camilladsp.log', Aug 20 18:06:50 volumio volumio[962]: '-l', Aug 20 18:06:50 volumio volumio[962]: 'warn', Aug 20 18:06:50 volumio volumio[962]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 20 18:06:50 volumio volumio[962]: ] Aug 20 18:06:50 volumio volumio[962]: } Aug 20 18:06:50 volumio volumio[962]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 18:06:51 volumio systemd[1]: Started FusionDsp Daemon. Aug 20 18:06:51 volumio sudo[5503]: pam_unix(sudo:session): session closed for user root Aug 20 18:06:51 volumio sudo[5515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 18:05 Aug 20 18:06:51 volumio sudo[5515]: 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"