-- Logs begin at Sat 2025-06-14 10:26:27 CEST, end at Sat 2025-06-14 18:42:40 CEST. -- Jun 14 18:41:24 rivoplus volumio[3108]: info: Installing build dependencies: finished with status 'done' Jun 14 18:41:24 rivoplus volumio[3108]: info: Installing build dependencies: finished with status 'done' Jun 14 18:41:34 rivoplus volumio[3108]: info: Collecting websocket_client (from camilladsp==1.0.0) Jun 14 18:41:34 rivoplus volumio[3108]: info: Collecting websocket_client (from camilladsp==1.0.0) Jun 14 18:41:35 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Jun 14 18:41:35 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Jun 14 18:41:35 rivoplus volumio[3108]: info: Building wheels for collected packages: camilladsp, PyYAML Jun 14 18:41:35 rivoplus volumio[3108]: info: Building wheels for collected packages: camilladsp, PyYAML Jun 14 18:41:35 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp: started Jun 14 18:41:35 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp: started Jun 14 18:41:36 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Jun 14 18:41:36 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Jun 14 18:41:36 rivoplus volumio[3108]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-en82vx_7/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Jun 14 18:41:36 rivoplus volumio[3108]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-en82vx_7/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Jun 14 18:41:36 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for PyYAML: started Jun 14 18:41:36 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for PyYAML: started Jun 14 18:41:39 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for PyYAML: finished with status 'done' Jun 14 18:41:39 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for PyYAML: finished with status 'done' Jun 14 18:41:39 rivoplus volumio[3108]: info: Stored in directory: /root/.cache/pip/wheels/e6/c6/ef/4e8ee93f1b79fc90562f1600d47189799f8213023d9dadafa2 Jun 14 18:41:39 rivoplus volumio[3108]: info: Stored in directory: /root/.cache/pip/wheels/e6/c6/ef/4e8ee93f1b79fc90562f1600d47189799f8213023d9dadafa2 Jun 14 18:41:40 rivoplus volumio[3108]: info: Successfully built camilladsp PyYAML Jun 14 18:41:40 rivoplus volumio[3108]: info: Successfully built camilladsp PyYAML Jun 14 18:41:40 rivoplus volumio[3108]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Jun 14 18:41:40 rivoplus volumio[3108]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Jun 14 18:41:40 rivoplus volumio[3108]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Jun 14 18:41:40 rivoplus volumio[3108]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Jun 14 18:41:47 rivoplus volumio[3108]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Jun 14 18:41:47 rivoplus volumio[3108]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Jun 14 18:41:47 rivoplus volumio[3108]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-d56axt2m Jun 14 18:41:47 rivoplus volumio[3108]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-d56axt2m Jun 14 18:41:49 rivoplus volumio[3108]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Jun 14 18:41:49 rivoplus volumio[3108]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Jun 14 18:41:49 rivoplus volumio[3108]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Jun 14 18:41:49 rivoplus volumio[3108]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Jun 14 18:41:50 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Jun 14 18:41:50 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Jun 14 18:41:50 rivoplus volumio[3108]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:50 rivoplus volumio[3108]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:51 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/64/de/375aa14daaee107f987da76ca32f7a907fea00fa8b8afb67dc09bec0de91/pyrsistent-0.19.3-py3-none-any.whl (57kB) Jun 14 18:41:51 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/64/de/375aa14daaee107f987da76ca32f7a907fea00fa8b8afb67dc09bec0de91/pyrsistent-0.19.3-py3-none-any.whl (57kB) Jun 14 18:41:51 rivoplus volumio[3108]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:51 rivoplus volumio[3108]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:52 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Jun 14 18:41:52 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Jun 14 18:41:52 rivoplus volumio[3108]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:52 rivoplus volumio[3108]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:52 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Jun 14 18:41:52 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Jun 14 18:41:52 rivoplus volumio[3108]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:52 rivoplus volumio[3108]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:53 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Jun 14 18:41:53 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Jun 14 18:41:53 rivoplus volumio[3108]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Jun 14 18:41:53 rivoplus volumio[3108]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Jun 14 18:41:53 rivoplus volumio[3108]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:53 rivoplus volumio[3108]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:54 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Jun 14 18:41:54 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Jun 14 18:41:54 rivoplus volumio[3108]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:54 rivoplus volumio[3108]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Jun 14 18:41:54 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Jun 14 18:41:54 rivoplus volumio[3108]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Jun 14 18:41:55 rivoplus volumio[3108]: info: Building wheels for collected packages: camilladsp-plot Jun 14 18:41:55 rivoplus volumio[3108]: info: Building wheels for collected packages: camilladsp-plot Jun 14 18:41:55 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp-plot: started Jun 14 18:41:55 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp-plot: started Jun 14 18:41:56 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Jun 14 18:41:56 rivoplus volumio[3108]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Jun 14 18:41:56 rivoplus volumio[3108]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-1f7c52lb/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Jun 14 18:41:56 rivoplus volumio[3108]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-1f7c52lb/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Jun 14 18:41:56 rivoplus volumio[3108]: info: Successfully built camilladsp-plot Jun 14 18:41:56 rivoplus volumio[3108]: info: Successfully built camilladsp-plot Jun 14 18:41:57 rivoplus volumio[3108]: info: Installing collected packages: pyrsistent, zipp, importlib-resources, pkgutil-resolve-name, typing-extensions, importlib-metadata, jsonschema, camilladsp-plot Jun 14 18:41:57 rivoplus volumio[3108]: info: Installing collected packages: pyrsistent, zipp, importlib-resources, pkgutil-resolve-name, typing-extensions, importlib-metadata, jsonschema, camilladsp-plot Jun 14 18:41:58 rivoplus volumio[3108]: 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 Jun 14 18:41:58 rivoplus volumio[3108]: 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 Jun 14 18:41:59 rivoplus volumio[3108]: info: copying hw detection script Jun 14 18:41:59 rivoplus volumio[3108]: info: copying hw detection script Jun 14 18:41:59 rivoplus volumio[3108]: info: Detected cpu architecture as aarch64 Jun 14 18:41:59 rivoplus volumio[3108]: info: Detected cpu architecture as aarch64 Jun 14 18:42:00 rivoplus volumio[3108]: info: camilladsp Jun 14 18:42:00 rivoplus volumio[3108]: info: camilladsp Jun 14 18:42:00 rivoplus sudo[22160]: 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 Jun 14 18:42:00 rivoplus sudo[22160]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:00 rivoplus sudo[22160]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:00 rivoplus sudo[22162]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Jun 14 18:42:00 rivoplus sudo[22162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:00 rivoplus sudo[22162]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:00 rivoplus sudo[22164]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Jun 14 18:42:00 rivoplus sudo[22164]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:01 rivoplus volumio[3108]: info: Reading package lists... Jun 14 18:42:01 rivoplus volumio[3108]: info: Reading package lists... Jun 14 18:42:01 rivoplus volumio[3108]: info: Building dependency tree... Jun 14 18:42:01 rivoplus volumio[3108]: info: Building dependency tree... Jun 14 18:42:01 rivoplus volumio[3108]: info: Reading state information... Jun 14 18:42:01 rivoplus volumio[3108]: info: Reading state information... Jun 14 18:42:03 rivoplus volumio[3108]: info: The following NEW packages will be installed: Jun 14 18:42:03 rivoplus volumio[3108]: info: The following NEW packages will be installed: Jun 14 18:42:03 rivoplus volumio[3108]: info: drc Jun 14 18:42:03 rivoplus volumio[3108]: info: drc Jun 14 18:42:03 rivoplus volumio[3108]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Jun 14 18:42:03 rivoplus volumio[3108]: info: Need to get 118 kB of archives. Jun 14 18:42:03 rivoplus volumio[3108]: info: After this operation, 471 kB of additional disk space will be used. Jun 14 18:42:03 rivoplus volumio[3108]: info: Get:1 http://deb.debian.org/debian buster/main armhf drc armhf 3.2.2~dfsg0-2 [118 kB] Jun 14 18:42:03 rivoplus volumio[3108]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Jun 14 18:42:03 rivoplus volumio[3108]: info: Need to get 118 kB of archives. Jun 14 18:42:03 rivoplus volumio[3108]: info: After this operation, 471 kB of additional disk space will be used. Jun 14 18:42:03 rivoplus volumio[3108]: info: Get:1 http://deb.debian.org/debian buster/main armhf drc armhf 3.2.2~dfsg0-2 [118 kB] Jun 14 18:42:04 rivoplus volumio[3108]: info: Fetched 118 kB in 0s (1266 kB/s) Jun 14 18:42:04 rivoplus volumio[3108]: info: Fetched 118 kB in 0s (1266 kB/s) Jun 14 18:42:04 rivoplus volumio[3108]: info: Selecting previously unselected package drc. Jun 14 18:42:04 rivoplus volumio[3108]: info: Selecting previously unselected package drc. Jun 14 18:42:06 rivoplus volumio[3108]: [620B blob data] Jun 14 18:42:06 rivoplus volumio[3108]: [620B blob data] Jun 14 18:42:06 rivoplus volumio[3108]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Unpacking drc (3.2.2~dfsg0-2) ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Unpacking drc (3.2.2~dfsg0-2) ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Setting up drc (3.2.2~dfsg0-2) ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Setting up drc (3.2.2~dfsg0-2) ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Processing triggers for man-db (2.8.5-2) ... Jun 14 18:42:06 rivoplus volumio[3108]: info: Processing triggers for man-db (2.8.5-2) ... Jun 14 18:42:07 rivoplus sudo[22164]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:07 rivoplus sudo[20387]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:07 rivoplus volumio[3108]: Plugin install end detected on script Jun 14 18:42:07 rivoplus volumio[3108]: Plugin install end detected on script Jun 14 18:42:07 rivoplus volumio[3108]: info: Install script completed Jun 14 18:42:07 rivoplus volumio[3108]: info: Adding reference to registry Jun 14 18:42:08 rivoplus volumio[3108]: info: Done installing plugin. Jun 14 18:42:08 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 14 18:42:08 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 14 18:42:08 rivoplus volumio[3108]: info: Folder /tmp/plugins removed Jun 14 18:42:08 rivoplus volumio[3108]: info: Folder /tmp/downloaded_plugin.zip removed Jun 14 18:42:08 rivoplus volumio[3108]: info: Folder /data/temp removed Jun 14 18:42:17 rivoplus volumio[3108]: info: Enabling plugin fusiondsp Jun 14 18:42:17 rivoplus volumio[3108]: info: Loading plugin "fusiondsp"... Jun 14 18:42:17 rivoplus volumio[3108]: info: Preparing to generate the ALSA configuration file Jun 14 18:42:18 rivoplus volumio[3108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 14 18:42:18 rivoplus volumio[3108]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 14 18:42:18 rivoplus volumio[3108]: info: Reading ALSA contributions from plugins. Jun 14 18:42:18 rivoplus volumio[3108]: info: Asound.conf file written Jun 14 18:42:18 rivoplus sudo[22316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 14 18:42:18 rivoplus sudo[22316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus sudo[22316]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994 Jun 14 18:42:18 rivoplus kernel: Err: can not set rate to 4290967296! Jun 14 18:42:18 rivoplus kernel: Range[3920000 - 500000000] Jun 14 18:42:18 rivoplus kernel: out of value, fixed it Jun 14 18:42:18 rivoplus kernel: id=0 set inskew=0 Jun 14 18:42:18 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:18 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:18 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Jun 14 18:42:18 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Jun 14 18:42:18 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Jun 14 18:42:18 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Jun 14 18:42:18 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Jun 14 18:42:18 rivoplus volumio[3108]: info: Output device has changed, restarting MPD Jun 14 18:42:18 rivoplus sudo[22321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 14 18:42:18 rivoplus sudo[22321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus sudo[22321]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus volumio[3108]: info: Output device has changed, restarting Shairport Sync Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:18 rivoplus sudo[22324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 14 18:42:18 rivoplus sudo[22324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus systemd[1]: Stopping Music Player Daemon... Jun 14 18:42:18 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:18 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:18 rivoplus volumio[3108]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 14 18:42:18 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:18 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:18 rivoplus volumio[3108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus systemd[1]: mpd.service: Succeeded. Jun 14 18:42:18 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 14 18:42:18 rivoplus systemd[1]: Starting Music Player Daemon... Jun 14 18:42:18 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:18 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:18 rivoplus volumio[3108]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus vtcs[15683]: [2025-06-14 18:42:18.428] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jun 14 18:42:18 rivoplus vtcs[15683]: [2025-06-14 18:42:18.431] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Jun 14 18:42:18 rivoplus vtcs[15683]: [2025-06-14 18:42:18.435] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jun 14 18:42:18 rivoplus volumio[3108]: info: PLUGIN START: fusiondsp Jun 14 18:42:18 rivoplus volumio[3108]: info: Loading i18n strings for locale nl Jun 14 18:42:18 rivoplus sudo[22338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:18 rivoplus sudo[22338]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: FusionDsp - mixtype--------------------- None Jun 14 18:42:18 rivoplus volumio[3108]: info: Preparing to generate the ALSA configuration file Jun 14 18:42:18 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Jun 14 18:42:18 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:18 rivoplus systemd[1]: vtcs.service: Succeeded. Jun 14 18:42:18 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Jun 14 18:42:18 rivoplus volumio[3108]: info: Done. Jun 14 18:42:18 rivoplus sudo[22338]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus sudo[22330]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 14 18:42:18 rivoplus sudo[22330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus sudo[22330]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus sudo[22345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:18 rivoplus sudo[22345]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus sudo[22345]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus volumio[3108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 14 18:42:18 rivoplus volumio[3108]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 14 18:42:18 rivoplus volumio[3108]: info: Reading ALSA contributions from plugins. Jun 14 18:42:18 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:18 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:18 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:18 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:18 rivoplus sudo[22355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 14 18:42:18 rivoplus sudo[22355]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus sudo[22355]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus sudo[22357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 14 18:42:18 rivoplus sudo[22357]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:18 rivoplus volumio[3108]: info: MPD Permissions set Jun 14 18:42:18 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:18 rivoplus qobuz-connect[15596]: 20250614 18:42:18.770 [15596.15596] INFO SampleApp: Stopping Local configuration server Jun 14 18:42:18 rivoplus qobuz-connect[15596]: 20250614 18:42:18.780 [15596.15596] INFO SampleApp: shat down connection on UNIX socket Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 14 18:42:18 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 14 18:42:18 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 14 18:42:18 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 14 18:42:18 rivoplus sudo[22357]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:18 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:18 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:20 rivoplus mpd[22349]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 14 18:42:20 rivoplus mpd[22349]: output: No 'audio_output' defined in config file Jun 14 18:42:20 rivoplus mpd[22349]: output: Successfully detected a sndio audio device Jun 14 18:42:20 rivoplus kernel: aml_tdm_open Jun 14 18:42:20 rivoplus kernel: Not init audio effects Jun 14 18:42:20 rivoplus kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Jun 14 18:42:20 rivoplus kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Jun 14 18:42:20 rivoplus kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Jun 14 18:42:20 rivoplus kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Jun 14 18:42:20 rivoplus kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc0503f5818, id(1), clksel(1) Jun 14 18:42:20 rivoplus kernel: aml_dai_set_tdm_fmt(), fmt not change Jun 14 18:42:20 rivoplus kernel: dump_pcm_setting(ffffffc0503f5818) Jun 14 18:42:20 rivoplus kernel: pcm_mode(1) Jun 14 18:42:20 rivoplus kernel: sysclk(12288000) Jun 14 18:42:20 rivoplus kernel: sysclk_bclk_ratio(4) Jun 14 18:42:20 rivoplus kernel: bclk(3072000) Jun 14 18:42:20 rivoplus kernel: bclk_lrclk_ratio(64) Jun 14 18:42:20 rivoplus kernel: lrclk(48000) Jun 14 18:42:20 rivoplus kernel: tx_mask(0x3) Jun 14 18:42:20 rivoplus kernel: rx_mask(0x3) Jun 14 18:42:20 rivoplus kernel: slots(2) Jun 14 18:42:20 rivoplus kernel: slot_width(32) Jun 14 18:42:20 rivoplus kernel: lane_mask_in(0x2) Jun 14 18:42:20 rivoplus kernel: lane_mask_out(0x1) Jun 14 18:42:20 rivoplus kernel: lane_oe_mask_in(0x0) Jun 14 18:42:20 rivoplus kernel: lane_oe_mask_out(0x0) Jun 14 18:42:20 rivoplus kernel: lane_lb_mask_in(0x0) Jun 14 18:42:20 rivoplus kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Jun 14 18:42:20 rivoplus kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Jun 14 18:42:20 rivoplus kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Jun 14 18:42:20 rivoplus kernel: aml_dai_set_clkdiv, div 4, clksel(1) Jun 14 18:42:20 rivoplus kernel: aml_dai_set_bclk_ratio, select I2S mode Jun 14 18:42:20 rivoplus kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Jun 14 18:42:20 rivoplus kernel: aml_tdm_prepare(), reset fddr Jun 14 18:42:20 rivoplus kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Jun 14 18:42:20 rivoplus kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Jun 14 18:42:20 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Jun 14 18:42:20 rivoplus kernel: tdm playback mute: 0, lane_cnt = 8 Jun 14 18:42:20 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Jun 14 18:42:20 rivoplus kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Jun 14 18:42:20 rivoplus kernel: tdm playback mute: 1, lane_cnt = 8 Jun 14 18:42:20 rivoplus kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Jun 14 18:42:20 rivoplus mpd[22349]: zeroconf: No global port, disabling zeroconf Jun 14 18:42:20 rivoplus systemd[1]: Started Music Player Daemon. Jun 14 18:42:20 rivoplus sudo[22324]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:23 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 14 18:42:23 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:23 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:42:23 rivoplus volumio[3108]: info: Not Reporting Auto name since its the default one Jun 14 18:42:24 rivoplus volumio-remote-updater[2831]: [2025-06-14 18:42:24] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jun 14 18:42:24 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22381, instance 1, run: true Jun 14 18:42:24 rivoplus volumio[3108]: info: camilladsp service started and running in background, instance 1 Jun 14 18:42:24 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:24 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:24 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:24 rivoplus volumio[3108]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Jun 14 18:42:24 rivoplus volumio[3108]: info: FusionDsp loaded Jun 14 18:42:24 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 18:42:24 rivoplus sudo[22388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 14 18:42:24 rivoplus sudo[22388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:24 rivoplus volumio[3108]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 14 18:42:24 rivoplus volumio[3108]: info: Adding Signal Path Element [object Object] Jun 14 18:42:24 rivoplus volumio[3108]: info: Adding fusiondspeq DSP Signal Path Element Jun 14 18:42:24 rivoplus volumio[3108]: info: Additional DSP elements updated Jun 14 18:42:24 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:24 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:24 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:24 rivoplus volumio[3108]: info: FusionDsp - ---- installed callbackRead Jun 14 18:42:24 rivoplus volumio[3108]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 14 18:42:24 rivoplus systemd[1]: Started FusionDsp Daemon. Jun 14 18:42:24 rivoplus sudo[22388]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:25 rivoplus volumio[3108]: info: Enabling plugin fusiondsp Jun 14 18:42:25 rivoplus volumio[3108]: info: Loading plugin "fusiondsp"... Jun 14 18:42:25 rivoplus volumio[3108]: info: Applying required configuration parameters for plugin fusiondsp Jun 14 18:42:25 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:25 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:25 rivoplus volumio[3108]: info: Starting Shairport Sync Jun 14 18:42:25 rivoplus sudo[22415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 14 18:42:25 rivoplus sudo[22415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:25 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 14 18:42:25 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 14 18:42:25 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:25 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:25 rivoplus sudo[22415]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:25 rivoplus volumio[3108]: error: FusionDsp - WebSocket error: [object Object] Jun 14 18:42:25 rivoplus volumio[3108]: info: Executing endpoint qc_getconfig Jun 14 18:42:25 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.826 [22364.22364] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 14 18:42:25 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:25 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.868 [22364.22364] INFO VolumeManager: [0xac4ef9b8]: Setting new playback volume: 75 Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.868 [22364.22364] INFO VolumeManager: [0xac4ef9b8]: Setting new mute state: 0 Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.868 [22364.22364] INFO QobuzConnect: [0xac4f0388]: Client initialized! Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.868 [22364.22364] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.895 [22364.22364] INFO LocalConfigManager: [0xac4ef298]: Starting Local Configuration server Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.895 [22364.22364] INFO SampleApp: Starting Local configuration server Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.898 [22364.22364] INFO SampleApp: Connected to UNIX socket client 0xac4e4ed8 Jun 14 18:42:25 rivoplus qobuz-connect[22364]: 20250614 18:42:25.966 [22364.22364] INFO SampleApp: Playback volume changed: 75 Jun 14 18:42:25 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 14 18:42:26 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 14 18:42:26 rivoplus volumio[3108]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 14 18:42:26 rivoplus volumio[3108]: info: Shairport-Sync Started Jun 14 18:42:26 rivoplus volumio[3108]: info: Asound.conf file unchanged, so no further update is needed Jun 14 18:42:26 rivoplus volumio[3108]: info: Output device has changed, restarting MPD Jun 14 18:42:26 rivoplus sudo[22429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 14 18:42:26 rivoplus sudo[22429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus sudo[22429]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus volumio[3108]: info: Output device has changed, restarting Shairport Sync Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:26 rivoplus sudo[22432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 14 18:42:26 rivoplus sudo[22432]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus systemd[1]: Stopping Music Player Daemon... Jun 14 18:42:26 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:26 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:26 rivoplus volumio[3108]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 14 18:42:26 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:26 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:26 rivoplus volumio[3108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:26 rivoplus systemd[1]: mpd.service: Succeeded. Jun 14 18:42:26 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 14 18:42:26 rivoplus systemd[1]: Starting Music Player Daemon... Jun 14 18:42:26 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:26 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:26 rivoplus volumio[3108]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:26 rivoplus volumio[3108]: info: Preparing to generate the ALSA configuration file Jun 14 18:42:26 rivoplus sudo[22442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:26 rivoplus sudo[22442]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus sudo[22442]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus sudo[22446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:26 rivoplus sudo[22446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus sudo[22438]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 14 18:42:26 rivoplus sudo[22438]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus sudo[22438]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus sudo[22446]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 14 18:42:26 rivoplus sudo[22455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 14 18:42:26 rivoplus sudo[22455]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus sudo[22455]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus sudo[22459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 14 18:42:26 rivoplus sudo[22459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:26 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:26 rivoplus qobuz-connect[22364]: 20250614 18:42:26.594 [22364.22364] INFO SampleApp: Stopping Local configuration server Jun 14 18:42:26 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 14 18:42:26 rivoplus qobuz-connect[22364]: 20250614 18:42:26.605 [22364.22364] INFO SampleApp: shat down connection on UNIX socket Jun 14 18:42:26 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 14 18:42:26 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 14 18:42:26 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 14 18:42:26 rivoplus sudo[22459]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus volumio[3108]: error: updateQueue error: null Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:26 rivoplus sudo[22463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 14 18:42:26 rivoplus sudo[22463]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:26 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:26 rivoplus sudo[22463]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus sudo[22466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 14 18:42:26 rivoplus sudo[22466]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:26 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 14 18:42:26 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:26 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 14 18:42:26 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 14 18:42:26 rivoplus volumio[3108]: 0+0 records in Jun 14 18:42:26 rivoplus volumio[3108]: 0+0 records out Jun 14 18:42:26 rivoplus volumio[3108]: 0 bytes copied, 0.000219876 s, 0.0 kB/s Jun 14 18:42:26 rivoplus systemd[1]: Started RAAT DAEMON. Jun 14 18:42:26 rivoplus sudo[22466]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:26 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22475, instance 1, run: true Jun 14 18:42:26 rivoplus volumio[3108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 14 18:42:26 rivoplus volumio[3108]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 14 18:42:26 rivoplus volumio[3108]: info: Reading ALSA contributions from plugins. Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:26 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:26 rivoplus volumio[3108]: info: Raat Daemon started successfully Jun 14 18:42:26 rivoplus volumio[3108]: info: MPD Permissions set Jun 14 18:42:26 rivoplus volumio[3108]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:26 rivoplus volumio[3108]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:26 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 14 18:42:26 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:26 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:26 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:26 rivoplus sudo[22490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 14 18:42:26 rivoplus sudo[22490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:27 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Jun 14 18:42:27 rivoplus sudo[22490]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: Not Reporting Auto name since its the default one Jun 14 18:42:27 rivoplus volumio[3108]: info: Executing endpoint qc_getconfig Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.089 [22462.22462] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.104 [22462.22462] INFO VolumeManager: [0xabde59b8]: Setting new playback volume: 75 Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.105 [22462.22462] INFO VolumeManager: [0xabde59b8]: Setting new mute state: 0 Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.105 [22462.22462] INFO QobuzConnect: [0xabde6388]: Client initialized! Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.106 [22462.22462] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 14 18:42:27 rivoplus volumio[3108]: info: Executing endpoint restartRAATSocket Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.125 [22462.22462] INFO LocalConfigManager: [0xabde5298]: Starting Local Configuration server Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.127 [22462.22462] INFO SampleApp: Starting Local configuration server Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.128 [22462.22462] INFO SampleApp: Connected to UNIX socket client 0xabddaed8 Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 14 18:42:27 rivoplus qobuz-connect[22462]: 20250614 18:42:27.238 [22462.22462] INFO SampleApp: Playback volume changed: 75 Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 14 18:42:27 rivoplus volumio[3108]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 14 18:42:27 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:27 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:27 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:27 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:27 rivoplus sudo[22510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 14 18:42:27 rivoplus sudo[22510]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:27 rivoplus volumio[3108]: info: Starting Shairport Sync Jun 14 18:42:27 rivoplus sudo[22510]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:27 rivoplus sudo[22514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 14 18:42:27 rivoplus sudo[22514]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:27 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 14 18:42:27 rivoplus volumio[3108]: info: Executing endpoint tc_getconfig Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 14 18:42:27 rivoplus vtcs[22496]: STARTING TidalConnect services, version: 1.5.1-beta1 Jun 14 18:42:27 rivoplus sudo[22515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 14 18:42:27 rivoplus sudo[22515]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:27 rivoplus vtcs[22496]: STARTED TidalConnect services. Jun 14 18:42:27 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 14 18:42:27 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:27 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 14 18:42:27 rivoplus volumio[3108]: info: Asound.conf file unchanged, so no further update is needed Jun 14 18:42:27 rivoplus volumio[3108]: info: Output device has changed, restarting MPD Jun 14 18:42:27 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 14 18:42:27 rivoplus systemd[1]: Started RAAT DAEMON. Jun 14 18:42:27 rivoplus sudo[22514]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:27 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 14 18:42:27 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 14 18:42:27 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:27 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:27 rivoplus sudo[22527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 14 18:42:27 rivoplus sudo[22527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:27 rivoplus volumio[3108]: info: Output device has changed, restarting Shairport Sync Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:27 rivoplus sudo[22515]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:27 rivoplus sudo[22527]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:27 rivoplus sudo[22535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 14 18:42:27 rivoplus sudo[22535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:27 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:27 rivoplus systemd[1]: mpd.service: Succeeded. Jun 14 18:42:27 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 14 18:42:27 rivoplus systemd[1]: Starting Music Player Daemon... Jun 14 18:42:27 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:27 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:27 rivoplus volumio[3108]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 14 18:42:27 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:27 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:27 rivoplus volumio[3108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:27 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:27 rivoplus volumio[3108]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: PLUGIN START: fusiondsp Jun 14 18:42:27 rivoplus volumio[3108]: info: Loading i18n strings for locale nl Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 14 18:42:27 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:27 rivoplus volumio[3108]: info: FusionDsp - mixtype--------------------- None Jun 14 18:42:27 rivoplus volumio[3108]: info: Preparing to generate the ALSA configuration file Jun 14 18:42:27 rivoplus sudo[22555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:27 rivoplus sudo[22555]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus volumio[3108]: info: Done. Jun 14 18:42:28 rivoplus sudo[22551]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 14 18:42:28 rivoplus sudo[22551]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Jun 14 18:42:28 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:28 rivoplus systemd[1]: vtcs.service: Succeeded. Jun 14 18:42:28 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Jun 14 18:42:28 rivoplus sudo[22551]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus sudo[22555]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus sudo[22559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:28 rivoplus sudo[22559]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus sudo[22559]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:28 rivoplus sudo[22568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 14 18:42:28 rivoplus sudo[22568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:28 rivoplus volumio[3108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 14 18:42:28 rivoplus volumio[3108]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 14 18:42:28 rivoplus volumio[3108]: info: Reading ALSA contributions from plugins. Jun 14 18:42:28 rivoplus sudo[22568]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus volumio[3108]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf Jun 14 18:42:28 rivoplus sudo[22570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 14 18:42:28 rivoplus sudo[22570]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus volumio[3108]: info: Executing endpoint tc_connect Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 14 18:42:28 rivoplus volumio[3108]: info: Connecting to TidalConnect Jun 14 18:42:28 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 14 18:42:28 rivoplus qobuz-connect[22462]: 20250614 18:42:28.276 [22462.22462] INFO SampleApp: Stopping Local configuration server Jun 14 18:42:28 rivoplus qobuz-connect[22462]: 20250614 18:42:28.287 [22462.22462] INFO SampleApp: shat down connection on UNIX socket Jun 14 18:42:28 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 14 18:42:28 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 14 18:42:28 rivoplus volumio[3108]: info: Executing endpoint restartRAATSocket Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 14 18:42:28 rivoplus volumio[3108]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 14 18:42:28 rivoplus volumio[3108]: info: MPD Permissions set Jun 14 18:42:28 rivoplus volumio[3108]: info: Shairport-Sync Started Jun 14 18:42:28 rivoplus volumio[3108]: info: Raat Daemon started successfully Jun 14 18:42:28 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 14 18:42:28 rivoplus sudo[22570]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:28 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:28 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 14 18:42:28 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:28 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:28 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:42:28 rivoplus volumio[3108]: info: Not Reporting Auto name since its the default one Jun 14 18:42:28 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 14 18:42:28 rivoplus volumio[3108]: info: Executing endpoint qc_getconfig Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.612 [22574.22574] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.619 [22574.22574] INFO VolumeManager: [0xabd1f9b8]: Setting new playback volume: 75 Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.620 [22574.22574] INFO VolumeManager: [0xabd1f9b8]: Setting new mute state: 0 Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.620 [22574.22574] INFO QobuzConnect: [0xabd20388]: Client initialized! Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.620 [22574.22574] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 14 18:42:28 rivoplus volumio[3108]: info: Starting Shairport Sync Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.637 [22574.22574] INFO LocalConfigManager: [0xabd1f298]: Starting Local Configuration server Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.637 [22574.22574] INFO SampleApp: Starting Local configuration server Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.638 [22574.22574] INFO SampleApp: Connected to UNIX socket client 0xabd14ed8 Jun 14 18:42:28 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 14 18:42:28 rivoplus volumio[3108]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 14 18:42:28 rivoplus sudo[22590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 14 18:42:28 rivoplus sudo[22590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 14 18:42:28 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 14 18:42:28 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:28 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:28 rivoplus qobuz-connect[22574]: 20250614 18:42:28.762 [22574.22574] INFO SampleApp: Playback volume changed: 75 Jun 14 18:42:28 rivoplus sudo[22590]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:28 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:28 rivoplus volumio[3108]: info: Asound.conf file unchanged, so no further update is needed Jun 14 18:42:28 rivoplus volumio[3108]: info: Output device has changed, restarting MPD Jun 14 18:42:28 rivoplus sudo[22596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 14 18:42:28 rivoplus sudo[22596]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus sudo[22596]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus sudo[22601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 14 18:42:28 rivoplus sudo[22601]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus sudo[22601]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:28 rivoplus volumio[3108]: info: Output device has changed, restarting Shairport Sync Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:28 rivoplus sudo[22602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 14 18:42:28 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:28 rivoplus sudo[22602]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 14 18:42:28 rivoplus sudo[22605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 14 18:42:28 rivoplus sudo[22605]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:28 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:28 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 14 18:42:28 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 14 18:42:28 rivoplus systemd[1]: Started RAAT DAEMON. Jun 14 18:42:28 rivoplus sudo[22602]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus volumio-remote-updater[2831]: [2025-06-14 18:42:29] [connect] Successful connection Jun 14 18:42:29 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:29 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:29 rivoplus volumio[3108]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 14 18:42:29 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:29 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:29 rivoplus volumio[3108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:29 rivoplus systemd[1]: mpd.service: Succeeded. Jun 14 18:42:29 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 14 18:42:29 rivoplus systemd[1]: Starting Music Player Daemon... Jun 14 18:42:29 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:29 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:29 rivoplus volumio[3108]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: Preparing to generate the ALSA configuration file Jun 14 18:42:29 rivoplus sudo[22625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:29 rivoplus sudo[22625]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:29 rivoplus sudo[22625]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus sudo[22628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:29 rivoplus sudo[22628]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:29 rivoplus sudo[22619]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 14 18:42:29 rivoplus sudo[22628]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus sudo[22619]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:29 rivoplus sudo[22619]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:29 rivoplus sudo[22637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:29 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:29 rivoplus sudo[22637]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:29 rivoplus volumio[3108]: info: Shairport-Sync Started Jun 14 18:42:29 rivoplus volumio[3108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 14 18:42:29 rivoplus volumio[3108]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 14 18:42:29 rivoplus volumio[3108]: info: Reading ALSA contributions from plugins. Jun 14 18:42:29 rivoplus sudo[22637]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus volumio[3108]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 14 18:42:29 rivoplus volumio[3108]: info: MPD Permissions set Jun 14 18:42:29 rivoplus volumio[3108]: info: Raat Daemon started successfully Jun 14 18:42:29 rivoplus volumio-remote-updater[2831]: [2025-06-14 18:42:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749919349 101 Jun 14 18:42:29 rivoplus volumio[3108]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Jun 14 18:42:29 rivoplus sudo[22640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 14 18:42:29 rivoplus sudo[22640]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:29 rivoplus volumio[3108]: info: Executing endpoint restartRAATSocket Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 14 18:42:29 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus qobuz-connect[22574]: 20250614 18:42:29.445 [22574.22574] INFO SampleApp: Stopping Local configuration server Jun 14 18:42:29 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 14 18:42:29 rivoplus qobuz-connect[22574]: 20250614 18:42:29.455 [22574.22574] INFO SampleApp: shat down connection on UNIX socket Jun 14 18:42:29 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 14 18:42:29 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 14 18:42:29 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 14 18:42:29 rivoplus sudo[22640]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:29 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:29 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:29 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 14 18:42:29 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:29 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: Not Reporting Auto name since its the default one Jun 14 18:42:29 rivoplus volumio[3108]: info: RAAT: Requesting Headphone Status Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 14 18:42:29 rivoplus volumio[3108]: info: Starting Shairport Sync Jun 14 18:42:29 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 14 18:42:29 rivoplus volumio[3108]: info: Executing endpoint qc_getconfig Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.867 [22647.22647] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 14 18:42:29 rivoplus volumio[3108]: info: MCU Signalled Headphone Mode Disabled Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 14 18:42:29 rivoplus volumio[3108]: info: Reporting Headphone State: false Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:29 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:29 rivoplus sudo[22667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.879 [22647.22647] INFO VolumeManager: [0xabd3c9b8]: Setting new playback volume: 75 Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.880 [22647.22647] INFO VolumeManager: [0xabd3c9b8]: Setting new mute state: 0 Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.880 [22647.22647] INFO QobuzConnect: [0xabd3d388]: Client initialized! Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.880 [22647.22647] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 14 18:42:29 rivoplus sudo[22667]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:29 rivoplus volumio[3108]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:29 rivoplus volumio[3108]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.910 [22647.22647] INFO LocalConfigManager: [0xabd3c298]: Starting Local Configuration server Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.910 [22647.22647] INFO SampleApp: Starting Local configuration server Jun 14 18:42:29 rivoplus qobuz-connect[22647]: 20250614 18:42:29.911 [22647.22647] INFO SampleApp: Connected to UNIX socket client 0xabd31ed8 Jun 14 18:42:29 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 14 18:42:29 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 14 18:42:29 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 14 18:42:29 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:29 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:29 rivoplus sudo[22667]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:29 rivoplus sudo[22671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 14 18:42:29 rivoplus sudo[22671]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus qobuz-connect[22647]: 20250614 18:42:30.017 [22647.22647] INFO SampleApp: Playback volume changed: 75 Jun 14 18:42:30 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:30 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:30 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Jun 14 18:42:30 rivoplus sudo[22671]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:30 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 14 18:42:30 rivoplus volumio[3108]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 14 18:42:30 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:30 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:30 rivoplus sudo[22684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 14 18:42:30 rivoplus sudo[22684]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus sudo[22684]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:30 rivoplus volumio[3108]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 14 18:42:30 rivoplus volumio[3108]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jun 14 18:42:30 rivoplus volumio[3108]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 14 18:42:30 rivoplus sudo[22689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 14 18:42:30 rivoplus sudo[22689]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 14 18:42:30 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:30 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 14 18:42:30 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 14 18:42:30 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22694, instance 2, run: true Jun 14 18:42:30 rivoplus volumio[3108]: info: camilladsp service started and running in background, instance 2 Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:30 rivoplus systemd[1]: Started RAAT DAEMON. Jun 14 18:42:30 rivoplus sudo[22689]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:30 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:30 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:30 rivoplus volumio[3108]: cannot open device 'volumioHw': Device or resource busy Jun 14 18:42:30 rivoplus volumio[3108]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 14 18:42:30 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:30 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:30 rivoplus volumio[3108]: cannot open device 'volumioHw': Device or resource busy Jun 14 18:42:30 rivoplus volumio[3108]: info: FusionDsp loaded Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 18:42:30 rivoplus volumio[3108]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 14 18:42:30 rivoplus volumio[3108]: info: Adding Signal Path Element [object Object] Jun 14 18:42:30 rivoplus volumio[3108]: info: Updating fusiondspeq DSP Signal Path Element Jun 14 18:42:30 rivoplus volumio[3108]: info: Additional DSP elements updated Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:30 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:30 rivoplus volumio[3108]: info: FusionDsp - ---- installed callbackRead Jun 14 18:42:30 rivoplus volumio[3108]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 14 18:42:30 rivoplus sudo[22716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 14 18:42:30 rivoplus sudo[22716]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:30 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:30 rivoplus volumio[3108]: info: FusionDsp - ---- read samplerate, raw: Jun 14 18:42:30 rivoplus volumio[3108]: error: FusionDsp - invalid sample rate Jun 14 18:42:30 rivoplus volumio[3108]: info: FusionDsp - ---- read samplerate, raw: Jun 14 18:42:30 rivoplus volumio[3108]: error: FusionDsp - invalid sample rate Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:30 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:30 rivoplus volumio[3108]: info: Raat Daemon started successfully Jun 14 18:42:30 rivoplus volumio[3108]: info: TidalConnect service started! Jun 14 18:42:30 rivoplus volumio[3108]: info: Shairport-Sync Started Jun 14 18:42:30 rivoplus sudo[22716]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:30 rivoplus volumio[3108]: (node:3108) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jun 14 18:42:30 rivoplus volumio[3108]: (node:3108) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jun 14 18:42:30 rivoplus volumio[3108]: (node:3108) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jun 14 18:42:30 rivoplus volumio[3108]: (node:3108) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jun 14 18:42:30 rivoplus volumio[3108]: (node:3108) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jun 14 18:42:30 rivoplus volumio[3108]: info: RAAT: Requesting Headphone Status Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 14 18:42:30 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22719, instance 2, run: true Jun 14 18:42:30 rivoplus volumio[3108]: info: Executing endpoint restartRAATSocket Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 14 18:42:30 rivoplus volumio[3108]: info: Executing endpoint tc_getconfig Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 14 18:42:30 rivoplus vtcs[22676]: STARTING TidalConnect services, version: 1.5.1-beta1 Jun 14 18:42:30 rivoplus vtcs[22676]: STARTED TidalConnect services. Jun 14 18:42:30 rivoplus volumio[3108]: info: Asound.conf file written Jun 14 18:42:30 rivoplus sudo[22735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 14 18:42:30 rivoplus sudo[22735]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus sudo[22735]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:30 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994 Jun 14 18:42:30 rivoplus kernel: Err: can not set rate to 4286967296! Jun 14 18:42:30 rivoplus kernel: Range[3920000 - 500000000] Jun 14 18:42:30 rivoplus kernel: out of value, fixed it Jun 14 18:42:30 rivoplus kernel: id=0 set inskew=0 Jun 14 18:42:30 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:30 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:30 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Jun 14 18:42:30 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Jun 14 18:42:30 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Jun 14 18:42:30 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Jun 14 18:42:30 rivoplus volumio[3108]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Jun 14 18:42:30 rivoplus volumio[3108]: info: Output device has changed, restarting MPD Jun 14 18:42:30 rivoplus sudo[22740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 14 18:42:30 rivoplus sudo[22740]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus sudo[22740]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:30 rivoplus volumio[3108]: info: Output device has changed, restarting Shairport Sync Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:30 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:30 rivoplus sudo[22743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 14 18:42:30 rivoplus sudo[22743]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:30 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:30 rivoplus systemd[1]: mpd.service: Succeeded. Jun 14 18:42:30 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 14 18:42:30 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:30 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:30 rivoplus volumio[3108]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 14 18:42:30 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:30 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:30 rivoplus volumio[3108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus systemd[1]: Starting Music Player Daemon... Jun 14 18:42:31 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:31 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:31 rivoplus volumio[3108]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus sudo[22752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:31 rivoplus sudo[22752]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:31 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Jun 14 18:42:31 rivoplus sudo[22755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 14 18:42:31 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:31 rivoplus systemd[1]: vtcs.service: Succeeded. Jun 14 18:42:31 rivoplus sudo[22755]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:31 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Jun 14 18:42:31 rivoplus sudo[22752]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:31 rivoplus sudo[22748]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 14 18:42:31 rivoplus sudo[22748]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:31 rivoplus sudo[22755]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:31 rivoplus sudo[22748]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:31 rivoplus volumio[3108]: info: MCU Signalled Headphone Mode Disabled Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 14 18:42:31 rivoplus volumio[3108]: info: Reporting Headphone State: false Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:31 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 14 18:42:31 rivoplus sudo[22766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 14 18:42:31 rivoplus sudo[22766]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:31 rivoplus volumio[3108]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 14 18:42:31 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:31 rivoplus volumio[3108]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf Jun 14 18:42:31 rivoplus sudo[22766]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:31 rivoplus sudo[22768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 14 18:42:31 rivoplus sudo[22768]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:31 rivoplus qobuz-connect[22647]: 20250614 18:42:31.389 [22647.22647] INFO SampleApp: Stopping Local configuration server Jun 14 18:42:31 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 14 18:42:31 rivoplus qobuz-connect[22647]: 20250614 18:42:31.400 [22647.22647] INFO SampleApp: shat down connection on UNIX socket Jun 14 18:42:31 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 14 18:42:31 rivoplus volumio[3108]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 14 18:42:31 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 14 18:42:31 rivoplus volumio[3108]: info: MPD Permissions set Jun 14 18:42:31 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:31 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 14 18:42:31 rivoplus sudo[22768]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:31 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:31 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22780, instance 2, run: true Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:31 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:31 rivoplus volumio[3108]: info: Executing endpoint tc_connect Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 14 18:42:31 rivoplus volumio[3108]: info: Connecting to TidalConnect Jun 14 18:42:31 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 14 18:42:31 rivoplus volumio[3108]: info: QobuzConnect: setDeactiveState invoked Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:31 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: Not Reporting Auto name since its the default one Jun 14 18:42:31 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 14 18:42:31 rivoplus volumio[3108]: info: Executing endpoint qc_getconfig Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 14 18:42:31 rivoplus volumio[3108]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:31 rivoplus volumio[3108]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.800 [22772.22772] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.814 [22772.22772] INFO VolumeManager: [0xac9e19b8]: Setting new playback volume: 75 Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.814 [22772.22772] INFO VolumeManager: [0xac9e19b8]: Setting new mute state: 0 Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.814 [22772.22772] INFO QobuzConnect: [0xac9e2388]: Client initialized! Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.814 [22772.22772] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.830 [22772.22772] INFO LocalConfigManager: [0xac9e1298]: Starting Local Configuration server Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.830 [22772.22772] INFO SampleApp: Starting Local configuration server Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.831 [22772.22772] INFO SampleApp: Connected to UNIX socket client 0xac9d6ed8 Jun 14 18:42:31 rivoplus volumio[3108]: info: RAAT: Requesting Headphone Status Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus sudo[22798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 14 18:42:31 rivoplus sudo[22798]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 14 18:42:31 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Jun 14 18:42:31 rivoplus sudo[22798]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:31 rivoplus qobuz-connect[22772]: 20250614 18:42:31.950 [22772.22772] INFO SampleApp: Playback volume changed: 75 Jun 14 18:42:31 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:31 rivoplus volumio[3108]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 14 18:42:31 rivoplus volumio[3108]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 14 18:42:32 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22809, instance 2, run: true Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:32 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 14 18:42:32 rivoplus volumio[3108]: No protocol specified Jun 14 18:42:32 rivoplus volumio[3108]: xcb_connection_has_error() returned true Jun 14 18:42:32 rivoplus volumio[3108]: info: MCU Signalled Headphone Mode Disabled Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 14 18:42:32 rivoplus volumio[3108]: info: Reporting Headphone State: false Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:32 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:32 rivoplus volumio[3108]: info: Starting Shairport Sync Jun 14 18:42:32 rivoplus sudo[22820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 14 18:42:32 rivoplus sudo[22820]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:32 rivoplus sudo[22820]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:32 rivoplus sudo[22824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 14 18:42:32 rivoplus sudo[22824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:32 rivoplus sudo[22827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 14 18:42:32 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:32 rivoplus sudo[22827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:32 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:32 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 14 18:42:32 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 14 18:42:32 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 14 18:42:32 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:32 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 14 18:42:32 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 14 18:42:32 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 14 18:42:32 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22834, instance 2, run: true Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus systemd[1]: Started RAAT DAEMON. Jun 14 18:42:32 rivoplus sudo[22824]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus sudo[22827]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:42:32 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:32 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:32 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 14 18:42:32 rivoplus volumio[3108]: info: Executing endpoint tc_getconfig Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 14 18:42:32 rivoplus vtcs[22804]: STARTING TidalConnect services, version: 1.5.1-beta1 Jun 14 18:42:32 rivoplus vtcs[22804]: STARTED TidalConnect services. Jun 14 18:42:32 rivoplus volumio[3108]: info: Shairport-Sync Started Jun 14 18:42:32 rivoplus volumio[3108]: info: Raat Daemon started successfully Jun 14 18:42:32 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22866, instance 2, run: true Jun 14 18:42:32 rivoplus volumio[3108]: info: Executing endpoint restartRAATSocket Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 14 18:42:32 rivoplus volumio[3108]: info: Executing endpoint tc_connect Jun 14 18:42:32 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 14 18:42:32 rivoplus volumio[3108]: info: Connecting to TidalConnect Jun 14 18:42:32 rivoplus volumio[3108]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:32 rivoplus volumio[3108]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:33 rivoplus sudo[22875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 14 18:42:33 rivoplus sudo[22875]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:33 rivoplus sudo[22875]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:33 rivoplus mpd[22765]: Jun 14 18:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 14 18:42:33 rivoplus systemd[1]: Started Music Player Daemon. Jun 14 18:42:33 rivoplus sudo[22432]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:33 rivoplus sudo[22535]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:33 rivoplus sudo[22743]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:33 rivoplus sudo[22605]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:37 rivoplus volumio[3108]: info: RAAT: Requesting Headphone Status Jun 14 18:42:37 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 14 18:42:37 rivoplus volumio[3108]: info: RAAT: Requesting Headphone Status Jun 14 18:42:37 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::servicePushState Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreStateMachine::pushState Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::volumioPushState Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: MRS: Pushing multiroomSync output update for this device Jun 14 18:42:38 rivoplus volumio[3108]: info: MRS: Pushing multiroomSync output Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::servicePushState Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreStateMachine::pushState Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::volumioPushState Jun 14 18:42:38 rivoplus volumio[3108]: info: CoreCommandRouter::volumioGetState Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: MRS: Pushing multiroomSync output update for this device Jun 14 18:42:38 rivoplus volumio[3108]: info: MRS: Pushing multiroomSync output Jun 14 18:42:38 rivoplus volumio[3108]: info: CorePlayQueue::getTrack 0 Jun 14 18:42:38 rivoplus volumio[3108]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jun 14 18:42:38 rivoplus volumio[3108]: info: TidalConnect service started! Jun 14 18:42:38 rivoplus volumio[3108]: info: TidalConnect service started! Jun 14 18:42:38 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:38 rivoplus volumio[3108]: info: TidalConnect service stoped! Jun 14 18:42:38 rivoplus volumio[3108]: info: TidalConnect service started! Jun 14 18:42:38 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22911, instance 2, run: true Jun 14 18:42:39 rivoplus volumio[3108]: info: MCU Signalled Headphone Mode Disabled Jun 14 18:42:39 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 14 18:42:39 rivoplus volumio[3108]: info: Reporting Headphone State: false Jun 14 18:42:39 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:39 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:39 rivoplus volumio[3108]: info: MCU Signalled Headphone Mode Disabled Jun 14 18:42:39 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 14 18:42:39 rivoplus volumio[3108]: info: Reporting Headphone State: false Jun 14 18:42:39 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:39 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:39 rivoplus volumio[3108]: error: MPD error: The expression evaluated to a falsy value: Jun 14 18:42:39 rivoplus volumio[3108]: assert.ok(self.idling) Jun 14 18:42:39 rivoplus volumio[3108]: error: The expression evaluated to a falsy value: Jun 14 18:42:39 rivoplus volumio[3108]: assert.ok(self.idling) Jun 14 18:42:39 rivoplus volumio[3108]: error: MPD error: The expression evaluated to a falsy value: Jun 14 18:42:39 rivoplus volumio[3108]: assert.ok(self.idling) Jun 14 18:42:39 rivoplus volumio[3108]: error: The expression evaluated to a falsy value: Jun 14 18:42:39 rivoplus volumio[3108]: assert.ok(self.idling) Jun 14 18:42:39 rivoplus volumio[3108]: error: MPD error: The expression evaluated to a falsy value: Jun 14 18:42:39 rivoplus volumio[3108]: assert.ok(self.idling) Jun 14 18:42:39 rivoplus volumio[3108]: error: The expression evaluated to a falsy value: Jun 14 18:42:39 rivoplus volumio[3108]: assert.ok(self.idling) Jun 14 18:42:39 rivoplus volumio[3108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 14 18:42:39 rivoplus volumio[3108]: error: updateQueue error: null Jun 14 18:42:39 rivoplus volumio[3108]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:39 rivoplus volumio[3108]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 14 18:42:39 rivoplus sudo[22923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 14 18:42:39 rivoplus sudo[22923]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:39 rivoplus volumio[3108]: info: camilladsp spawned new process with pid 22924, instance 2, run: true Jun 14 18:42:39 rivoplus volumio[3108]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf Jun 14 18:42:39 rivoplus sudo[22923]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:39 rivoplus volumio[3108]: info: FusionDsp - Stopping FusionDsp service Jun 14 18:42:39 rivoplus volumio[3108]: info: camilladsp stopping service pid 22924... Jun 14 18:42:39 rivoplus volumio[3108]: info: camilladsp service terminated, instance 2 Jun 14 18:42:39 rivoplus sudo[22936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Jun 14 18:42:39 rivoplus sudo[22936]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:42:39 rivoplus systemd[1]: Stopping FusionDsp Daemon... Jun 14 18:42:39 rivoplus volumio[22390]: Backend configuration: Jun 14 18:42:39 rivoplus volumio[22390]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jun 14 18:42:39 rivoplus volumio[22390]: active_config_txt: null Jun 14 18:42:39 rivoplus volumio[22390]: camilla_host: 127.0.0.1 Jun 14 18:42:39 rivoplus volumio[22390]: camilla_port: 9876 Jun 14 18:42:39 rivoplus volumio[22390]: coeff_dir: /data/INTERNAL/FusionDsp/filters Jun 14 18:42:39 rivoplus volumio[22390]: config_dir: /data/configuration/audio_interface/fusiondsp Jun 14 18:42:39 rivoplus volumio[22390]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jun 14 18:42:39 rivoplus volumio[22390]: log_file: /tmp/camilladsp.log Jun 14 18:42:39 rivoplus volumio[22390]: on_get_active_config: null Jun 14 18:42:39 rivoplus volumio[22390]: on_set_active_config: null Jun 14 18:42:39 rivoplus volumio[22390]: port: 5011 Jun 14 18:42:39 rivoplus volumio[22390]: supported_capture_types: null Jun 14 18:42:39 rivoplus volumio[22390]: supported_playback_types: null Jun 14 18:42:39 rivoplus volumio[22390]: update_config_symlink: false Jun 14 18:42:39 rivoplus volumio[22390]: update_config_txt: false Jun 14 18:42:39 rivoplus volumio[22390]: ======== Running on http://0.0.0.0:5011 ======== Jun 14 18:42:39 rivoplus volumio[22390]: (Press CTRL+C to quit) Jun 14 18:42:39 rivoplus volumio[3108]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 14 18:42:39 rivoplus systemd[1]: fusiondsp.service: Succeeded. Jun 14 18:42:39 rivoplus systemd[1]: Stopped FusionDsp Daemon. Jun 14 18:42:39 rivoplus sudo[22936]: pam_unix(sudo:session): session closed for user root Jun 14 18:42:39 rivoplus volumio[3108]: info: FusionDsp - Reporting Fusion DSP Disabled Jun 14 18:42:39 rivoplus volumio[3108]: info: Removing fusiondspeq DSP Signal Path Element Jun 14 18:42:39 rivoplus volumio[3108]: info: Additional DSP elements updated Jun 14 18:42:39 rivoplus volumio[3108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 18:42:39 rivoplus volumio[3108]: info: Updating RAAT Signal Path Jun 14 18:42:40 rivoplus volumio[3108]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf Jun 14 18:42:40 rivoplus volumio[3108]: info: FusionDsp - Stopping FusionDsp service Jun 14 18:42:40 rivoplus volumio[3108]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 18:42:40 rivoplus volumio[3108]: TypeError: Cannot read property 'stop' of null Jun 14 18:42:40 rivoplus volumio[3108]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Jun 14 18:42:40 rivoplus volumio[3108]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 14 18:42:40 rivoplus volumio[3108]: at /volumio/app/pluginmanager.js:956:12 Jun 14 18:42:40 rivoplus volumio[3108]: at ChildProcess.exithandler (child_process.js:374:7) Jun 14 18:42:40 rivoplus volumio[3108]: at ChildProcess.emit (events.js:400:28) Jun 14 18:42:40 rivoplus volumio[3108]: at maybeClose (internal/child_process.js:1088:16) Jun 14 18:42:40 rivoplus volumio[3108]: at Socket. (internal/child_process.js:446:11) Jun 14 18:42:40 rivoplus volumio[3108]: at Socket.emit (events.js:400:28) Jun 14 18:42:40 rivoplus volumio[3108]: at Pipe. (net.js:686:12) Jun 14 18:42:40 rivoplus volumio[3108]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 18:42:40 rivoplus sudo[22949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 18:41 Jun 14 18:42:40 rivoplus sudo[22949]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:41:30 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="e2256d79dd6d0ae59eb47f10e57a5e95"