-- Logs begin at Thu 2019-02-14 12:11:59 SAST, end at Wed 2024-08-28 17:31:05 SAST. -- Aug 28 17:30:03 volumio volumio[1001]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/volumio/buster/armhf Aug 28 17:30:07 volumio volumio[1001]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/volumio/buster/armhf Aug 28 17:30:07 volumio volumio[1001]: info: FusionDsp - Stopping FusionDsp service Aug 28 17:30:07 volumio volumio[1001]: info: camilladsp stopping service pid 3545... Aug 28 17:30:07 volumio volumio[1001]: info: camilladsp service terminated, instance 1 Aug 28 17:30:07 volumio sudo[3674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Aug 28 17:30:07 volumio sudo[3674]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:07 volumio systemd[1]: Stopping FusionDsp Daemon... Aug 28 17:30:07 volumio volumio[1306]: Backend configuration: Aug 28 17:30:07 volumio volumio[1306]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Aug 28 17:30:07 volumio volumio[1306]: active_config_txt: null Aug 28 17:30:07 volumio volumio[1306]: camilla_host: 127.0.0.1 Aug 28 17:30:07 volumio volumio[1306]: camilla_port: 9876 Aug 28 17:30:07 volumio volumio[1306]: coeff_dir: /data/INTERNAL/FusionDsp/filters Aug 28 17:30:07 volumio volumio[1306]: config_dir: /data/configuration/audio_interface/fusiondsp Aug 28 17:30:07 volumio volumio[1306]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Aug 28 17:30:07 volumio volumio[1306]: log_file: /tmp/camilladsp.log Aug 28 17:30:07 volumio volumio[1306]: on_get_active_config: null Aug 28 17:30:07 volumio volumio[1306]: on_set_active_config: null Aug 28 17:30:07 volumio volumio[1306]: port: 5011 Aug 28 17:30:07 volumio volumio[1306]: supported_capture_types: null Aug 28 17:30:07 volumio volumio[1306]: supported_playback_types: null Aug 28 17:30:07 volumio volumio[1306]: update_config_symlink: false Aug 28 17:30:07 volumio volumio[1306]: update_config_txt: false Aug 28 17:30:07 volumio volumio[1306]: ======== Running on http://0.0.0.0:5011 ======== Aug 28 17:30:07 volumio volumio[1306]: (Press CTRL+C to quit) Aug 28 17:30:07 volumio systemd[1]: fusiondsp.service: Succeeded. Aug 28 17:30:07 volumio systemd[1]: Stopped FusionDsp Daemon. Aug 28 17:30:07 volumio sudo[3674]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:07 volumio volumio[1001]: info: FusionDsp - Reporting Fusion DSP Disabled Aug 28 17:30:07 volumio volumio[1001]: info: Removing fusiondspeq DSP Signal Path Element Aug 28 17:30:07 volumio volumio[1001]: info: Check plugin dependencies Aug 28 17:30:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 17:30:07 volumio volumio[1001]: info: Rename folder Aug 28 17:30:07 volumio volumio[1001]: info: Folder /tmp/downloaded_plugin.zip removed Aug 28 17:30:07 volumio volumio[1001]: info: Move to category Aug 28 17:30:08 volumio volumio[1001]: info: Checking if install.sh is present Aug 28 17:30:08 volumio volumio[1001]: info: Executing install.sh Aug 28 17:30:08 volumio sudo[3690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Aug 28 17:30:08 volumio sudo[3690]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:08 volumio volumio[1001]: info: creating filters folder and copying demo filters Aug 28 17:30:09 volumio volumio[1001]: info: copying demo flters Aug 28 17:30:09 volumio volumio[1001]: info: Installing/fusiondsp dependencies Aug 28 17:30:09 volumio sudo[3713]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Aug 28 17:30:09 volumio sudo[3713]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:09 volumio volumio[1001]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Aug 28 17:30:09 volumio volumio[1001]: info: Get:2 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] Aug 28 17:30:09 volumio volumio[1001]: info: Get:3 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] Aug 28 17:30:10 volumio volumio[1001]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] Aug 28 17:30:11 volumio volumio[1001]: info: Fetched 469 kB in 2s (233 kB/s) Aug 28 17:30:14 volumio volumio[1001]: info: Reading package lists... Aug 28 17:30:15 volumio volumio[1001]: info: Building dependency tree... Aug 28 17:30:15 volumio volumio[1001]: info: Reading state information... Aug 28 17:30:15 volumio volumio[1001]: info: All packages are up to date. Aug 28 17:30:15 volumio sudo[3713]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:15 volumio sudo[3929]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Aug 28 17:30:15 volumio sudo[3929]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:15 volumio volumio[1001]: info: Reading package lists... Aug 28 17:30:15 volumio volumio[1001]: info: Building dependency tree... Aug 28 17:30:15 volumio volumio[1001]: info: Reading state information... Aug 28 17:30:16 volumio volumio[1001]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1). Aug 28 17:30:16 volumio sudo[3929]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:16 volumio volumio[1001]: info: python3-pip is already the newest version (18.1-5+rpt1). Aug 28 17:30:16 volumio volumio[1001]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. Aug 28 17:30:16 volumio sudo[3935]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Aug 28 17:30:16 volumio sudo[3935]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:16 volumio volumio[1001]: info: lib/systemd/system/fusiondsp.service Aug 28 17:30:16 volumio sudo[3935]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:21 volumio volumio[1001]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Aug 28 17:30:21 volumio volumio[1001]: info: more info at http://www.winimage.com/zLibDll/unzip.html Aug 28 17:30:21 volumio volumio[1001]: info: Aug 28 17:30:21 volumio volumio[1001]: info: cgui-1.0.0.zip opened Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/ Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/LICENSE.txt Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/README.md Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/build/ Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/robots.txt Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/logo512.png Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/asset-manifest.json Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/index.html Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/.put_statics_here Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/favicon.ico Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/logo192.png Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/manifest.json Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/css-variables.css Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/service-worker.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/build/static/ Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/build/static/css/ Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/main.1503f6cd.css Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/build/static/media/ Aug 28 17:30:21 volumio sudo[3949]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/build/static/js/ Aug 28 17:30:21 volumio sudo[3949]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.71e11955.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.71e11955.js.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/config/ Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/config/camillagui.yml Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/config/gui-config.yml Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/backend/ Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/filters_test.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/version.py Aug 28 17:30:21 volumio sudo[3949]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/filters.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/settings.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/views.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/filterdefaults.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__init__.py Aug 28 17:30:21 volumio volumio[1001]: info: creating directory: cgui/backend/__pycache__/ Aug 28 17:30:21 volumio sudo[3951]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Aug 28 17:30:21 volumio sudo[3951]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:21 volumio sudo[3951]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:21 volumio sudo[3953]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Aug 28 17:30:21 volumio sudo[3953]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:21 volumio sudo[3953]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/routes.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/backend/filemanagement.py Aug 28 17:30:21 volumio volumio[1001]: info: extracting: cgui/main.py Aug 28 17:30:25 volumio volumio[1001]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 28 17:30:25 volumio volumio[1001]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Aug 28 17:30:25 volumio volumio[1001]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-sxfcwt3z Aug 28 17:30:27 volumio volumio[1001]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp==1.0.0 from git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 in /usr/local/lib/python3.7/dist-packages Aug 28 17:30:27 volumio volumio[1001]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0.1) Aug 28 17:30:27 volumio volumio[1001]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.6.1) Aug 28 17:30:27 volumio volumio[1001]: info: Building wheels for collected packages: camilladsp Aug 28 17:30:27 volumio volumio[1001]: info: Running setup.py bdist_wheel for camilladsp: started Aug 28 17:30:28 volumio volumio[1001]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Aug 28 17:30:28 volumio volumio[1001]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-to0y5qej/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Aug 28 17:30:28 volumio volumio[1001]: info: Successfully built camilladsp Aug 28 17:30:32 volumio volumio[1001]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 28 17:30:32 volumio volumio[1001]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Aug 28 17:30:32 volumio volumio[1001]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-hfc15scq Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0) Aug 28 17:30:34 volumio volumio[1001]: info: Requirement already satisfied: zipp>=0.5 in /usr/local/lib/python3.7/dist-packages (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) (3.15.0) Aug 28 17:30:34 volumio volumio[1001]: info: Building wheels for collected packages: camilladsp-plot Aug 28 17:30:34 volumio volumio[1001]: info: Running setup.py bdist_wheel for camilladsp-plot: started Aug 28 17:30:35 volumio volumio[1001]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Aug 28 17:30:35 volumio volumio[1001]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-834beu4g/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Aug 28 17:30:35 volumio volumio[1001]: info: Successfully built camilladsp-plot Aug 28 17:30:36 volumio volumio[1001]: info: copying hw detection script Aug 28 17:30:36 volumio volumio[1001]: info: Detected cpu architecture as armv7l Aug 28 17:30:37 volumio volumio[1001]: info: camilladsp Aug 28 17:30:37 volumio sudo[4051]: 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 Aug 28 17:30:37 volumio sudo[4051]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:37 volumio sudo[4051]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:37 volumio sudo[4053]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Aug 28 17:30:37 volumio sudo[4053]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:37 volumio sudo[4053]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:37 volumio sudo[4055]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Aug 28 17:30:37 volumio sudo[4055]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:30:37 volumio volumio[1001]: info: Reading package lists... Aug 28 17:30:38 volumio volumio[1001]: info: Building dependency tree... Aug 28 17:30:38 volumio volumio[1001]: info: Reading state information... Aug 28 17:30:39 volumio volumio[1001]: info: drc is already the newest version (3.2.2~dfsg0-2). Aug 28 17:30:39 volumio sudo[4055]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:39 volumio volumio[1001]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. Aug 28 17:30:39 volumio sudo[3690]: pam_unix(sudo:session): session closed for user root Aug 28 17:30:39 volumio volumio[1001]: info: Install script completed Aug 28 17:30:39 volumio volumio[1001]: info: Done installing plugin. Aug 28 17:30:39 volumio volumio[1001]: info: Enabling plugin fusiondsp Aug 28 17:30:39 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 17:30:39 volumio volumio[1001]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.54","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Podcast","name":"podcast","category":"music_service","version":"2.2.0","icon":"fa-podcast","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"0.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.5","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.3","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.2.1","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":false,"active":false},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.4.0","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":true,"active":true}] Aug 28 17:30:39 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 28 17:30:39 volumio volumio[1001]: info: Folder /tmp/plugins removed Aug 28 17:30:39 volumio volumio[1001]: info: Folder /tmp/downloaded_plugin.zip removed Aug 28 17:30:39 volumio volumio[1001]: Plugin install end detected on script Aug 28 17:30:39 volumio volumio[1001]: info: Folder /data/temp removed Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::volumioStop Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::stop Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::stPlaybackTimer Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Aug 28 17:30:52 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::pushState Aug 28 17:30:52 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::serviceStop Aug 28 17:30:52 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::serviceStop Aug 28 17:30:52 volumio volumio[1001]: info: [1724859052736] ControllerWebradio::stop Aug 28 17:30:52 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Aug 28 17:30:52 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 28 17:30:52 volumio volumio[1001]: info: Aug 28 17:30:52 volumio volumio[1001]: ---------------------------- MPD announces state update: player Aug 28 17:30:52 volumio volumio[1001]: info: sendMpdCommand stop took 11 milliseconds Aug 28 17:30:52 volumio volumio[1001]: info: ControllerMpd::getState Aug 28 17:30:52 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Aug 28 17:30:52 volumio volumio[1001]: info: sendMpdCommand status took 31 milliseconds Aug 28 17:30:52 volumio volumio[1001]: verbose: ControllerMpd::parseState Aug 28 17:30:52 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 17:30:52 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 28 17:30:52 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Aug 28 17:30:52 volumio volumio[1001]: info: ControllerMpd::pushState Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Aug 28 17:30:52 volumio volumio[1001]: info: CoreStateMachine::pushState Aug 28 17:30:52 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 17:30:52 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Aug 28 17:30:52 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:52 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 28 17:30:52 volumio volumio[1001]: info: ------------------------------ 44ms Aug 28 17:30:52 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 28 17:30:52 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 30 seconds. Aug 28 17:30:54 volumio volumio[1001]: info: CoreCommandRouter::volumioPlay Aug 28 17:30:54 volumio volumio[1001]: info: CoreStateMachine::play index undefined Aug 28 17:30:54 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 17:30:54 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:54 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Aug 28 17:30:54 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:54 volumio volumio[1001]: info: [1724859054398] ControllerWebradio::clearAddPlayTrack Aug 28 17:30:54 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Aug 28 17:30:54 volumio volumio[1001]: info: sendMpdCommand stop took 1 milliseconds Aug 28 17:30:54 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Aug 28 17:30:54 volumio volumio[1001]: info: Aug 28 17:30:54 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Aug 28 17:30:54 volumio volumio[1001]: info: Ignoring MPD Status Update Aug 28 17:30:54 volumio volumio[1001]: info: sendMpdCommand clear took 1 milliseconds Aug 28 17:30:54 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand load "http://sc2.radiocaroline.net:8000/;?rp_source=1&=&&___cb=948129876368084" Aug 28 17:30:55 volumio volumio[1001]: error: updateQueue error: null Aug 28 17:30:55 volumio volumio[1001]: info: ------------------------------ 1329ms Aug 28 17:30:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand add "http://sc2.radiocaroline.net:8000/;?rp_source=1&=&&___cb=948129876368084" Aug 28 17:30:55 volumio volumio[1001]: info: Aug 28 17:30:55 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Aug 28 17:30:55 volumio volumio[1001]: info: Ignoring MPD Status Update Aug 28 17:30:55 volumio volumio[1001]: info: sendMpdCommand add "http://sc2.radiocaroline.net:8000/;?rp_source=1&=&&___cb=948129876368084" took 3 milliseconds Aug 28 17:30:55 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 28 17:30:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Aug 28 17:30:55 volumio volumio[1001]: info: ------------------------------ 2ms Aug 28 17:30:55 volumio volumio[1001]: info: sendMpdCommand play took 1 milliseconds Aug 28 17:30:56 volumio volumio[1001]: info: Aug 28 17:30:56 volumio volumio[1001]: ---------------------------- MPD announces state update: player Aug 28 17:30:56 volumio volumio[1001]: info: ControllerMpd::getState Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Aug 28 17:30:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: Aug 28 17:30:56 volumio volumio[1001]: error: FusionDsp - invalid sample rate Aug 28 17:30:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 24000,S32_LE,2,32 Aug 28 17:30:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 24000 Aug 28 17:30:56 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 28 17:30:56 volumio volumio[1001]: info: FusionDsp - crossfeed jameier Aug 28 17:30:56 volumio volumio[1001]: info: Aug 28 17:30:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Aug 28 17:30:56 volumio volumio[1001]: info: Ignoring MPD Status Update Aug 28 17:30:56 volumio volumio[1001]: info: Aug 28 17:30:56 volumio volumio[1001]: ---------------------------- MPD announces state update: player Aug 28 17:30:56 volumio volumio[1001]: info: sendMpdCommand status took 21 milliseconds Aug 28 17:30:56 volumio volumio[1001]: info: ControllerMpd::getState Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::parseState Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 17:30:56 volumio volumio[1001]: info: ------------------------------ 2ms Aug 28 17:30:56 volumio volumio[1001]: info: sendMpdCommand status took 1 milliseconds Aug 28 17:30:56 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::parseState Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Aug 28 17:30:56 volumio volumio[1001]: info: ControllerMpd::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Aug 28 17:30:56 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:56 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":";?rp_source=1&=&&___cb=948129876368084","artist":"Radio Caroline","album":null,"uri":"http://sc2.radiocaroline.net:8000/;?rp_source=1&=&&___cb=948129876368084","trackType":""} Aug 28 17:30:56 volumio volumio[1001]: verbose: CURRENT POSITION 0 Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Aug 28 17:30:56 volumio volumio[1001]: info: ------------------------------ 25ms Aug 28 17:30:56 volumio volumio[1001]: error: FusionDsp - WebSocket error: [object Object] Aug 28 17:30:56 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Aug 28 17:30:56 volumio volumio[1001]: info: ControllerMpd::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Aug 28 17:30:56 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:56 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":";?rp_source=1&=&&___cb=948129876368084","artist":"Radio Caroline","album":null,"uri":"http://sc2.radiocaroline.net:8000/;?rp_source=1&=&&___cb=948129876368084","trackType":""} Aug 28 17:30:56 volumio volumio[1001]: verbose: CURRENT POSITION 0 Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Aug 28 17:30:56 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Aug 28 17:30:56 volumio volumio[1001]: info: ------------------------------ 13ms Aug 28 17:30:56 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 28 17:30:56 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 28 17:30:56 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Aug 28 17:30:56 volumio volumio[1001]: info: Aug 28 17:30:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Aug 28 17:30:56 volumio volumio[1001]: info: Ignoring MPD Status Update Aug 28 17:30:56 volumio volumio[1001]: info: Aug 28 17:30:56 volumio volumio[1001]: ---------------------------- MPD announces state update: player Aug 28 17:30:56 volumio volumio[1001]: info: ControllerMpd::getState Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Aug 28 17:30:56 volumio volumio[1001]: info: ------------------------------ 1ms Aug 28 17:30:56 volumio volumio[1001]: info: sendMpdCommand status took 1 milliseconds Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::parseState Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 17:30:56 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 28 17:30:56 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Aug 28 17:30:56 volumio volumio[1001]: info: ControllerMpd::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Aug 28 17:30:56 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Aug 28 17:30:56 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Radio Caroline - www.radiocaroline.co.uk (16:30)","artist":"Radio Caroline","album":null,"uri":"http://sc2.radiocaroline.net:8000/;?rp_source=1&=&&___cb=948129876368084","trackType":""} Aug 28 17:30:56 volumio volumio[1001]: verbose: CURRENT POSITION 0 Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Aug 28 17:30:56 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreStateMachine::pushState Aug 28 17:30:56 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Aug 28 17:30:56 volumio volumio[1001]: info: ------------------------------ 20ms Aug 28 17:30:56 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 28 17:30:56 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 28 17:31:04 volumio volumio[1001]: info: Enabling plugin fusiondsp Aug 28 17:31:04 volumio volumio[1001]: info: Loading plugin "fusiondsp"... Aug 28 17:31:04 volumio volumio[1001]: info: Applying required configuration parameters for plugin fusiondsp Aug 28 17:31:04 volumio volumio[1001]: info: Preparing to generate the ALSA configuration file Aug 28 17:31:04 volumio volumio[1001]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 28 17:31:04 volumio volumio[1001]: info: Reading ALSA contributions from plugins. Aug 28 17:31:04 volumio volumio[1001]: info: Asound.conf file unchanged, so no further update is needed Aug 28 17:31:04 volumio volumio[1001]: info: Output device has changed, restarting MPD Aug 28 17:31:04 volumio sudo[4162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 17:31:04 volumio sudo[4162]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio volumio[1001]: info: Output device has changed, restarting Shairport Sync Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 17:31:04 volumio sudo[4162]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:04 volumio sudo[4165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 17:31:04 volumio sudo[4165]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio systemd[1]: Stopping Music Player Daemon... Aug 28 17:31:04 volumio volumio[1001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 17:31:04 volumio volumio[1001]: info: PLUGIN START: fusiondsp Aug 28 17:31:04 volumio volumio[1001]: info: Loading i18n strings for locale en Aug 28 17:31:04 volumio systemd[1]: mpd.service: Succeeded. Aug 28 17:31:04 volumio systemd[1]: Stopped Music Player Daemon. Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: FusionDsp - mixtype--------------------- Hardware Aug 28 17:31:04 volumio volumio[1001]: info: Preparing to generate the ALSA configuration file Aug 28 17:31:04 volumio volumio[1001]: info: Done. Aug 28 17:31:04 volumio volumio[1001]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 28 17:31:04 volumio volumio[1001]: info: Reading ALSA contributions from plugins. Aug 28 17:31:04 volumio volumio[1001]: info: MPD Permissions set Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: Starting Shairport Sync Aug 28 17:31:04 volumio systemd[1]: Starting Music Player Daemon... Aug 28 17:31:04 volumio volumio[1001]: info: Asound.conf file unchanged, so no further update is needed Aug 28 17:31:04 volumio volumio[1001]: info: Output device has changed, restarting MPD Aug 28 17:31:04 volumio sudo[4176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 17:31:04 volumio sudo[4176]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 28 17:31:04 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 28 17:31:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 28 17:31:04 volumio sudo[4179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 17:31:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 28 17:31:04 volumio sudo[4179]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio sudo[4176]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:04 volumio sudo[4170]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 17:31:04 volumio sudo[4170]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio sudo[4170]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:04 volumio sudo[4179]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:04 volumio volumio[1001]: info: Output device has changed, restarting Shairport Sync Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 17:31:04 volumio sudo[4188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 17:31:04 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 28 17:31:04 volumio systemd[1]: mpd.service: Succeeded. Aug 28 17:31:04 volumio systemd[1]: Stopped Music Player Daemon. Aug 28 17:31:04 volumio volumio[1001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 17:31:04 volumio volumio[1001]: info: MPD Permissions set Aug 28 17:31:04 volumio volumio[1001]: info: Shairport-Sync Started Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: Starting Shairport Sync Aug 28 17:31:04 volumio systemd[1]: Starting Music Player Daemon... Aug 28 17:31:04 volumio sudo[4199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 17:31:04 volumio sudo[4199]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 28 17:31:04 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 28 17:31:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 28 17:31:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 28 17:31:04 volumio sudo[4199]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:04 volumio volumio[1001]: info: Shairport-Sync Started Aug 28 17:31:04 volumio sudo[4192]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 17:31:04 volumio sudo[4192]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 17:31:04 volumio sudo[4192]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:04 volumio volumio[1001]: error: Upnp client error: Error: This socket has been ended by the other party Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:05 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:05 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 17:31:05 volumio volumio[1001]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 17:31:05 volumio volumio[1001]: TypeError: Cannot read property 'off' of undefined Aug 28 17:31:05 volumio volumio[1001]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Aug 28 17:31:05 volumio volumio[1001]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Aug 28 17:31:05 volumio volumio[1001]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Aug 28 17:31:05 volumio volumio[1001]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1537:29) Aug 28 17:31:05 volumio volumio[1001]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1387:47) Aug 28 17:31:05 volumio volumio[1001]: at Socket.emit (events.js:315:20) Aug 28 17:31:05 volumio volumio[1001]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 28 17:31:05 volumio volumio[1001]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 28 17:31:05 volumio volumio[1001]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 17:31:05 volumio mpd[4203]: Aug 28 17:31 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 28 17:31:05 volumio systemd[1]: Started Music Player Daemon. Aug 28 17:31:05 volumio sudo[4165]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:05 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Aug 28 17:31:05 volumio sudo[4217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-28 17:30 Aug 28 17:31:05 volumio sudo[4217]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"