-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2025-05-02 11:55:42 CEST. -- May 02 11:54:00 volumio volumio[883]: info: Setting up python3-crypto (2.6.1-9+b1) ... May 02 11:54:00 volumio volumio[883]: info: Setting up python-pip-whl (18.1-5+rpt1) ... May 02 11:54:00 volumio volumio[883]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... May 02 11:54:00 volumio volumio[883]: info: Setting up python3-yarl (1.3.0-1) ... May 02 11:54:01 volumio volumio[883]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... May 02 11:54:01 volumio volumio[883]: info: Setting up python3-asn1crypto (0.24.0-1) ... May 02 11:54:02 volumio volumio[883]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... May 02 11:54:02 volumio volumio[883]: info: Setting up python3-cffi-backend (1.12.2-1) ... May 02 11:54:02 volumio volumio[883]: info: Setting up libalgorithm-merge-perl (0.08-3) ... May 02 11:54:02 volumio volumio[883]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... May 02 11:54:02 volumio volumio[883]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... May 02 11:54:02 volumio volumio[883]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... May 02 11:54:02 volumio volumio[883]: info: Setting up dpkg-dev (1.19.8) ... May 02 11:54:03 volumio volumio[883]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... May 02 11:54:03 volumio volumio[883]: info: Setting up python3-pip (18.1-5+rpt1) ... May 02 11:54:04 volumio ntpd[772]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 02 11:54:04 volumio volumio[883]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... May 02 11:54:04 volumio volumio[883]: info: Setting up cpp (4:8.3.0-1+rpi2) ... May 02 11:54:04 volumio volumio[883]: info: Setting up python3-keyrings.alt (3.1.1-1) ... May 02 11:54:04 volumio volumio[883]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... May 02 11:54:05 volumio volumio[883]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... May 02 11:54:05 volumio volumio[883]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... May 02 11:54:05 volumio volumio[883]: info: Setting up gcc (4:8.3.0-1+rpi2) ... May 02 11:54:05 volumio volumio[883]: info: Setting up python3-secretstorage (2.3.1-2) ... May 02 11:54:05 volumio volumio[883]: info: Setting up python3-dev (3.7.3-1) ... May 02 11:54:05 volumio volumio[883]: info: Setting up g++-8 (8.3.0-6+rpi1) ... May 02 11:54:05 volumio volumio[883]: info: Setting up python3-keyring (17.1.1-1) ... May 02 11:54:06 volumio volumio[883]: info: Setting up g++ (4:8.3.0-1+rpi2) ... May 02 11:54:06 volumio volumio[883]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode May 02 11:54:06 volumio volumio[883]: info: Setting up build-essential (12.6) ... May 02 11:54:06 volumio volumio[883]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... May 02 11:54:07 volumio sudo[3138]: pam_unix(sudo:session): session closed for user root May 02 11:54:07 volumio sudo[4018]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / May 02 11:54:07 volumio sudo[4018]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:07 volumio volumio[883]: info: lib/systemd/system/fusiondsp.service May 02 11:54:07 volumio sudo[4018]: pam_unix(sudo:session): session closed for user root May 02 11:54:10 volumio volumio[883]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant May 02 11:54:10 volumio volumio[883]: info: more info at http://www.winimage.com/zLibDll/unzip.html May 02 11:54:10 volumio volumio[883]: info: May 02 11:54:10 volumio volumio[883]: info: cgui-1.0.0.zip opened May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/ May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/LICENSE.txt May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/README.md May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/build/ May 02 11:54:10 volumio sudo[4089]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/robots.txt May 02 11:54:10 volumio sudo[4089]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/logo512.png May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/asset-manifest.json May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/index.html May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/.put_statics_here May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/favicon.ico May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/logo192.png May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/manifest.json May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/css-variables.css May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js May 02 11:54:10 volumio sudo[4089]: pam_unix(sudo:session): session closed for user root May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/service-worker.js May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/build/static/ May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/build/static/css/ May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/main.1503f6cd.css May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/build/static/media/ May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg May 02 11:54:10 volumio sudo[4091]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/build/static/js/ May 02 11:54:10 volumio sudo[4091]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.71e11955.js May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js May 02 11:54:10 volumio sudo[4091]: pam_unix(sudo:session): session closed for user root May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.71e11955.js.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/config/ May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/config/camillagui.yml May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/config/gui-config.yml May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/backend/ May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/filters_test.py May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/version.py May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/filters.py May 02 11:54:10 volumio sudo[4094]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/settings.py May 02 11:54:10 volumio sudo[4094]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/views.py May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/filterdefaults.py May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__init__.py May 02 11:54:10 volumio volumio[883]: info: creating directory: cgui/backend/__pycache__/ May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc May 02 11:54:10 volumio sudo[4094]: pam_unix(sudo:session): session closed for user root May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/routes.py May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/backend/filemanagement.py May 02 11:54:10 volumio volumio[883]: info: extracting: cgui/main.py May 02 11:54:14 volumio volumio[883]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple May 02 11:54:14 volumio volumio[883]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 May 02 11:54:14 volumio volumio[883]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-w4lo6ays May 02 11:54:17 volumio volumio[883]: info: Collecting PyYAML (from camilladsp==1.0.0) May 02 11:54:19 volumio volumio[883]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) May 02 11:54:19 volumio volumio[883]: info: Collecting websocket_client (from camilladsp==1.0.0) May 02 11:54:19 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) May 02 11:54:20 volumio volumio[883]: info: Building wheels for collected packages: camilladsp May 02 11:54:20 volumio volumio[883]: info: Running setup.py bdist_wheel for camilladsp: started May 02 11:54:20 volumio volumio[883]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' May 02 11:54:20 volumio volumio[883]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-cx4zs_pm/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 May 02 11:54:20 volumio volumio[883]: info: Successfully built camilladsp May 02 11:54:21 volumio volumio[883]: info: Installing collected packages: PyYAML, websocket-client, camilladsp May 02 11:54:21 volumio volumio[883]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 May 02 11:54:24 volumio volumio[883]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple May 02 11:54:24 volumio volumio[883]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 May 02 11:54:24 volumio volumio[883]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-aq7ga6yk May 02 11:54:26 volumio volumio[883]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) May 02 11:54:26 volumio volumio[883]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) May 02 11:54:27 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) May 02 11:54:27 volumio volumio[883]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) May 02 11:54:28 volumio volumio[883]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) May 02 11:54:28 volumio volumio[883]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) May 02 11:54:29 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl May 02 11:54:29 volumio volumio[883]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) May 02 11:54:29 volumio volumio[883]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) May 02 11:54:29 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl May 02 11:54:29 volumio volumio[883]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) May 02 11:54:30 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl May 02 11:54:30 volumio volumio[883]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) May 02 11:54:31 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl May 02 11:54:31 volumio volumio[883]: info: Collecting zipp>=0.5 (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) May 02 11:54:31 volumio volumio[883]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl May 02 11:54:31 volumio volumio[883]: info: Building wheels for collected packages: camilladsp-plot May 02 11:54:31 volumio volumio[883]: info: Running setup.py bdist_wheel for camilladsp-plot: started May 02 11:54:32 volumio volumio[883]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' May 02 11:54:32 volumio volumio[883]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-mlqepmy5/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 May 02 11:54:32 volumio volumio[883]: info: Successfully built camilladsp-plot May 02 11:54:33 volumio volumio[883]: info: Installing collected packages: pyrsistent, pkgutil-resolve-name, typing-extensions, zipp, importlib-metadata, importlib-resources, jsonschema, camilladsp-plot May 02 11:54:33 volumio volumio[883]: info: Successfully installed camilladsp-plot-1.0.2 importlib-metadata-6.7.0 importlib-resources-5.12.0 jsonschema-4.17.3 pkgutil-resolve-name-1.3.10 pyrsistent-0.19.3 typing-extensions-4.7.1 zipp-3.15.0 May 02 11:54:33 volumio volumio[883]: info: copying hw detection script May 02 11:54:33 volumio volumio[883]: info: Detected cpu architecture as armv7l May 02 11:54:36 volumio sudo[4190]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params May 02 11:54:36 volumio sudo[4190]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:36 volumio sudo[4190]: pam_unix(sudo:session): session closed for user root May 02 11:54:36 volumio sudo[4192]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params May 02 11:54:36 volumio sudo[4192]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:36 volumio sudo[4192]: pam_unix(sudo:session): session closed for user root May 02 11:54:36 volumio sudo[4194]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc May 02 11:54:36 volumio sudo[4194]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:54:36 volumio volumio[883]: info: Reading package lists... May 02 11:54:36 volumio dhcpcd[2135]: eth0: deleting route to 192.168.1.0/24 May 02 11:54:36 volumio dhcpcd[2135]: eth0: deleting default route via 192.168.1.20 May 02 11:54:36 volumio dhcpcd[933]: eth0: pid 2135 deleted route to 192.168.1.0/24 May 02 11:54:36 volumio dhcpcd[933]: eth0: pid 2135 deleted default route via 192.168.1.20 May 02 11:54:36 volumio volumio[883]: info: Building dependency tree... May 02 11:54:36 volumio dhcpcd[933]: eth0: hardware address 56:81:e3:99:b4:9b claims 192.168.1.61 May 02 11:54:36 volumio volumio[883]: info: Reading state information... May 02 11:54:37 volumio volumio[883]: info: The following NEW packages will be installed: May 02 11:54:37 volumio volumio[883]: info: drc May 02 11:54:43 volumio volumio[883]: info: 0 upgraded, 1 newly installed, 0 to remove and 2 not upgraded. May 02 11:54:43 volumio volumio[883]: info: Need to get 112 kB of archives. May 02 11:54:43 volumio volumio[883]: info: After this operation, 512 kB of additional disk space will be used. May 02 11:54:43 volumio volumio[883]: info: Get:1 http://ftp.fi.muni.cz/pub/linux/raspbian/raspbian buster/main armhf drc armhf 3.2.2~dfsg0-2 [112 kB] May 02 11:54:43 volumio volumio[883]: verbose: New Socket.io Connection to 192.168.1.62 from 192.168.1.73 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 CCleaner/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 May 02 11:54:43 volumio volumio[883]: verbose: New Socket.io Connection to 192.168.1.61 from 192.168.1.73 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 CCleaner/134.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: Fetched 112 kB in 6s (20.3 kB/s) May 02 11:54:43 volumio volumio[883]: info: Received Get System Info May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 11:54:43 volumio volumio[883]: info: Discovery: Getting this device information May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetVisibleSources May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 02 11:54:43 volumio volumio[883]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 02 11:54:43 volumio volumio[883]: info: Received Get System Info May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 11:54:43 volumio volumio[883]: info: Discovery: Getting this device information May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:54:43 volumio volumio[883]: info: Listing playlists May 02 11:54:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue May 02 11:54:43 volumio volumio[883]: info: CoreStateMachine::getQueue May 02 11:54:43 volumio volumio[883]: info: CorePlayQueue::getQueue May 02 11:54:44 volumio volumio[883]: info: Selecting previously unselected package drc. May 02 11:54:44 volumio volumio[883]: [620B blob data] May 02 11:54:44 volumio volumio[883]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... May 02 11:54:44 volumio volumio[883]: info: Unpacking drc (3.2.2~dfsg0-2) ... May 02 11:54:44 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 02 11:54:44 volumio volumio[883]: info: Setting up drc (3.2.2~dfsg0-2) ... May 02 11:54:45 volumio sudo[4194]: pam_unix(sudo:session): session closed for user root May 02 11:54:45 volumio sudo[2877]: pam_unix(sudo:session): session closed for user root May 02 11:54:45 volumio volumio[883]: Plugin install end detected on script May 02 11:54:45 volumio volumio[883]: info: Install script completed May 02 11:54:45 volumio volumio[883]: info: Adding reference to registry May 02 11:54:45 volumio volumio[883]: info: Done installing plugin. May 02 11:54:45 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 11:54:45 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 02 11:54:45 volumio volumio[883]: info: Folder /tmp/plugins removed May 02 11:54:45 volumio volumio[883]: info: Folder /tmp/downloaded_plugin.zip removed May 02 11:54:45 volumio volumio[883]: info: Folder /data/temp removed May 02 11:54:53 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 02 11:54:57 volumio volumio[883]: info: CoreCommandRouter::Close All Modals sent May 02 11:54:57 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted May 02 11:54:58 volumio dnsmasq-dhcp[874]: no address range available for DHCP request via wlan0 May 02 11:55:01 volumio dnsmasq-dhcp[874]: no address range available for DHCP request via wlan0 May 02 11:55:22 volumio volumio[883]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf May 02 11:55:23 volumio dnsmasq-dhcp[874]: no address range available for DHCP request via wlan0 May 02 11:55:27 volumio volumio[883]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf May 02 11:55:27 volumio volumio[883]: info: Folder /tmp/plugins removed May 02 11:55:28 volumio volumio[883]: info: Check plugin dependencies May 02 11:55:28 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 11:55:28 volumio volumio[883]: info: Checking if plugin already exists May 02 11:55:28 volumio volumio[883]: info: Rename folder May 02 11:55:29 volumio volumio[883]: info: Folder /tmp/downloaded_plugin.zip removed May 02 11:55:29 volumio volumio[883]: info: Move to category May 02 11:55:30 volumio volumio[883]: info: Checking if install.sh is present May 02 11:55:30 volumio volumio[883]: info: Executing install.sh May 02 11:55:30 volumio sudo[4411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/youtube2/install.sh May 02 11:55:30 volumio sudo[4411]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 11:55:30 volumio sudo[4411]: pam_unix(sudo:session): session closed for user root May 02 11:55:30 volumio volumio[883]: info: YouTube2 plugin installed May 02 11:55:30 volumio volumio[883]: Plugin install end detected on script May 02 11:55:30 volumio volumio[883]: info: Install script completed May 02 11:55:30 volumio volumio[883]: info: Adding reference to registry May 02 11:55:30 volumio volumio[883]: info: Done installing plugin. May 02 11:55:30 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 11:55:30 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 02 11:55:30 volumio volumio[883]: info: Folder /tmp/downloaded_plugin.zip removed May 02 11:55:30 volumio volumio[883]: info: Folder /tmp/plugins removed May 02 11:55:30 volumio volumio[883]: info: Folder /data/temp removed May 02 11:55:32 volumio volumio[883]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf May 02 11:55:32 volumio volumio[883]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf May 02 11:55:40 volumio volumio[883]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf May 02 11:55:40 volumio volumio[883]: info: Folder /tmp/plugins removed May 02 11:55:40 volumio volumio[883]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/youtube2/volumio/buster/armhf May 02 11:55:40 volumio volumio[883]: info: Folder /tmp/plugins removed May 02 11:55:41 volumio volumio[883]: info: Check plugin dependencies May 02 11:55:41 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 11:55:41 volumio volumio[883]: info: Checking if plugin already exists May 02 11:55:41 volumio volumio[883]: info: An error occurred installing the plugin. Rolling back config May 02 11:55:41 volumio volumio[883]: info: Plugin folders cleanup May 02 11:55:41 volumio volumio[883]: info: Scanning into folder /volumio/app/plugins/ May 02 11:55:41 volumio volumio[883]: info: Scanning category audio_interface May 02 11:55:41 volumio volumio[883]: info: Scanning category miscellanea May 02 11:55:41 volumio volumio[883]: info: Scanning category music_service May 02 11:55:41 volumio volumio[883]: info: Scanning category plugins.json May 02 11:55:41 volumio volumio[883]: info: Scanning category system_controller May 02 11:55:41 volumio volumio[883]: info: Scanning category user_interface May 02 11:55:41 volumio volumio[883]: info: Scanning into folder /data/plugins/ May 02 11:55:41 volumio volumio[883]: info: Scanning category audio_interface May 02 11:55:41 volumio volumio[883]: info: Scanning category music_service May 02 11:55:41 volumio volumio[883]: info: Plugin folders cleanup completed May 02 11:55:41 volumio volumio[883]: info: Error: Error May 02 11:55:41 volumio volumio[883]: info: Folder /tmp/plugins removed May 02 11:55:41 volumio volumio[883]: info: Folder /tmp/downloaded_plugin.zip removed May 02 11:55:41 volumio volumio[883]: info: Folder /tmp/downloaded_plugin.zip removed May 02 11:55:42 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:55:42 volumio volumio[883]: info: CorePlayQueue::getTrack 1 May 02 11:55:42 volumio volumio[883]: info: Prefetching next song May 02 11:55:42 volumio volumio[883]: info: [1746179742143] ControllerTidal::prefetch May 02 11:55:42 volumio volumio[883]: info: Getting stream with soundQuality HI_RES May 02 11:55:42 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/298421450&soundQuality=HI_RES" May 02 11:55:42 volumio volumio[883]: info: May 02 11:55:42 volumio volumio[883]: ---------------------------- MPD announces system playlist update May 02 11:55:42 volumio volumio[883]: info: Ignoring MPD Status Update May 02 11:55:42 volumio volumio[883]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/298421450&soundQuality=HI_RES" took 4 milliseconds May 02 11:55:42 volumio volumio[883]: info: CoreStateMachine::setConsumeUpdateService mpd May 02 11:55:42 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand consume 1 May 02 11:55:42 volumio volumio[883]: info: May 02 11:55:42 volumio volumio[883]: ---------------------------- MPD announces state update: options May 02 11:55:42 volumio volumio[883]: info: ------------------------------ 6ms May 02 11:55:42 volumio volumio[883]: info: sendMpdCommand consume 1 took 4 milliseconds May 02 11:55:42 volumio volumio[883]: info: ControllerMpd::getState May 02 11:55:42 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand status May 02 11:55:42 volumio volumio[883]: info: sendMpdCommand status took 4 milliseconds May 02 11:55:42 volumio volumio[883]: verbose: ControllerMpd::parseState May 02 11:55:42 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 02 11:55:42 volumio volumio[883]: info: sendMpdCommand playlistinfo took 0 milliseconds May 02 11:55:42 volumio volumio[883]: verbose: ControllerMpd::parseTrackInfo May 02 11:55:42 volumio volumio[883]: info: ControllerMpd::pushState May 02 11:55:42 volumio volumio[883]: info: CoreCommandRouter::servicePushState May 02 11:55:42 volumio volumio[883]: info: CoreStateMachine::pushState May 02 11:55:42 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 11:55:42 volumio volumio[883]: info: CoreCommandRouter::volumioPushState May 02 11:55:42 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device May 02 11:55:42 volumio volumio[883]: info: MRS: Pushing multiroomSync output May 02 11:55:42 volumio volumio[883]: info: CorePlayQueue::getTrack 0 May 02 11:55:42 volumio volumio[883]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"298421450&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/298421450&soundQuality=HI_RES","trackType":"tidal"} May 02 11:55:42 volumio volumio[883]: verbose: CURRENT POSITION 0 May 02 11:55:42 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop May 02 11:55:42 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop May 02 11:55:42 volumio volumio[883]: info: CoreStateMachine::pushState May 02 11:55:42 volumio volumio[883]: info: CoreCommandRouter::volumioPushState May 02 11:55:42 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device May 02 11:55:42 volumio volumio[883]: info: MRS: Pushing multiroomSync output May 02 11:55:42 volumio volumio[883]: info: No code May 02 11:55:42 volumio volumio[883]: info: CoreStateMachine::pushState May 02 11:55:42 volumio volumio[883]: info: CoreCommandRouter::volumioPushState May 02 11:55:42 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device May 02 11:55:42 volumio volumio[883]: info: MRS: Pushing multiroomSync output May 02 11:55:42 volumio volumio[883]: info: ------------------------------ 49ms May 02 11:55:42 volumio volumio[883]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.d9f0fblH5vaOcDRqP0kdnQ07S2u1.de8801d3472549eb3e1989fc8b974952.state.status' May 02 11:55:42 volumio volumio[883]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.d9f0fblH5vaOcDRqP0kdnQ07S2u1.de8801d3472549eb3e1989fc8b974952.state.status' May 02 11:55:42 volumio volumio[883]: info: Folder /data/temp removed May 02 11:55:42 volumio volumio[883]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 11:55:42 volumio volumio[883]: Error: Unable to resolve or reject the same promise twice May 02 11:55:42 volumio volumio[883]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 02 11:55:42 volumio volumio[883]: at /volumio/app/pluginmanager.js:1087:11 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) May 02 11:55:42 volumio volumio[883]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 May 02 11:55:42 volumio volumio[883]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 11:55:42 volumio sudo[4450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-02 11:54 May 02 11:55:42 volumio sudo[4450]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"