-- Logs begin at Sat 2026-02-21 16:15:55 CET, end at Sun 2026-02-22 00:00:55 CET. -- Feb 21 23:59:00 rivo volumio[3224]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Feb 21 23:59:00 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:00.579+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:00 rivo volumio[3224]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-12v0h508 Feb 21 23:59:00 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:00.602+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:01 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:02 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:02 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:03 rivo volumio[3224]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Feb 21 23:59:03 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:03.531+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:03 rivo volumio[3224]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Feb 21 23:59:03 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:03.609+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:04 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Feb 21 23:59:04 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:04.625+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:05 rivo volumio[3224]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Feb 21 23:59:05 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:05.043+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:05 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Feb 21 23:59:05 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:05.789+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:06 rivo volumio[3224]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Feb 21 23:59:06 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:06.060+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:06 rivo volumio[3224]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Feb 21 23:59:06 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:06.170+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:06 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Feb 21 23:59:06 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:06.487+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:06 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:06 rivo volumio[3224]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Feb 21 23:59:06 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:06.667+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:07 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Feb 21 23:59:07 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:07.698+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:08 rivo volumio[3224]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Feb 21 23:59:08 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:08.094+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:08 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/64/de/375aa14daaee107f987da76ca32f7a907fea00fa8b8afb67dc09bec0de91/pyrsistent-0.19.3-py3-none-any.whl (57kB) Feb 21 23:59:08 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:08.653+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:08 rivo volumio[3224]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Feb 21 23:59:08 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:08.884+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:09 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Feb 21 23:59:09 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:09.416+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:09 rivo volumio[3224]: 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) Feb 21 23:59:09 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:09.647+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:10 rivo volumio[3224]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Feb 21 23:59:10 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:10.020+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:10 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:10 rivo volumio[3224]: info: Building wheels for collected packages: camilladsp-plot Feb 21 23:59:10 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:10.248+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:10 rivo volumio[3224]: info: Running setup.py bdist_wheel for camilladsp-plot: started Feb 21 23:59:10 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:10.268+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:10 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:10 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:11 rivo volumio[3224]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Feb 21 23:59:11 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:11.860+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:11 rivo volumio[3224]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-snon3my0/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Feb 21 23:59:11 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:11.882+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:11 rivo volumio[3224]: info: Successfully built camilladsp-plot Feb 21 23:59:11 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:11.916+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:12 rivo ntpd[3458]: Soliciting pool server 94.198.159.16 Feb 21 23:59:12 rivo volumio[3224]: info: Installing collected packages: zipp, importlib-resources, typing-extensions, importlib-metadata, pyrsistent, pkgutil-resolve-name, jsonschema, camilladsp-plot Feb 21 23:59:12 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:12.715+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:13 rivo volumio[3224]: 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 Feb 21 23:59:13 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:13.915+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:14 rivo volumio[3224]: info: copying hw detection script Feb 21 23:59:14 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:14.225+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:14 rivo volumio[3224]: info: Detected cpu architecture as aarch64 Feb 21 23:59:14 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:14.259+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:14 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:16 rivo go-librespot[26998]: time="2026-02-21T23:59:16+01:00" level=trace msg="sent dealer ping" Feb 21 23:59:16 rivo go-librespot[26998]: time="2026-02-21T23:59:16+01:00" level=trace msg="received dealer pong" Feb 21 23:59:17 rivo go-librespot[26998]: time="2026-02-21T23:59:17+01:00" level=trace msg="received accesspoint ping" Feb 21 23:59:17 rivo go-librespot[26998]: time="2026-02-21T23:59:17+01:00" level=trace msg="received accesspoint pong ack" Feb 21 23:59:18 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:18 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:18 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:21 rivo sudo[26890]: 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 Feb 21 23:59:21 rivo sudo[26890]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:21 rivo sudo[26890]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:21 rivo sudo[26892]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Feb 21 23:59:21 rivo sudo[26892]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:21 rivo sudo[26892]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:21 rivo sudo[26894]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Feb 21 23:59:21 rivo sudo[26894]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:21 rivo volumio[3224]: info: Reading package lists... Feb 21 23:59:21 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:21.626+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:21 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:22 rivo volumio[3224]: info: Building dependency tree... Feb 21 23:59:22 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:22.298+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:22 rivo volumio[3224]: info: Reading state information... Feb 21 23:59:22 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:22.321+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:22 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:23 rivo volumio[3224]: info: The following NEW packages will be installed: Feb 21 23:59:23 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:23.651+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:23 rivo volumio[3224]: info: drc Feb 21 23:59:23 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:23.678+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:23 rivo volumio[3224]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Feb 21 23:59:23 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:23.879+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:23 rivo volumio[3224]: info: Need to get 118 kB of archives. Feb 21 23:59:23 rivo volumio[3224]: info: After this operation, 471 kB of additional disk space will be used. Feb 21 23:59:23 rivo volumio[3224]: info: Get:1 http://archive.debian.org/debian buster/main armhf drc armhf 3.2.2~dfsg0-2 [118 kB] Feb 21 23:59:23 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:23.900+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:23 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:23.906+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:23 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:23.909+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:25 rivo volumio[3224]: info: Fetched 118 kB in 0s (542 kB/s) Feb 21 23:59:25 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:25.370+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:25 rivo volumio[3224]: info: Selecting previously unselected package drc. Feb 21 23:59:25 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:25.463+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:26 rivo volumio[3224]: [620B blob data] Feb 21 23:59:26 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:26.063+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:26 rivo volumio[3224]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Feb 21 23:59:26 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:26.087+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:26 rivo volumio[3224]: info: Unpacking drc (3.2.2~dfsg0-2) ... Feb 21 23:59:26 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:26.101+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:26 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:26 rivo volumio[3224]: info: Setting up drc (3.2.2~dfsg0-2) ... Feb 21 23:59:26 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:26.453+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:26 rivo volumio[3224]: info: Processing triggers for man-db (2.8.5-2) ... Feb 21 23:59:26 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:26.475+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:26 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:27 rivo sudo[26894]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:27 rivo volumio[3224]: Plugin install end detected on script Feb 21 23:59:27 rivo sudo[24747]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:27 rivo volumio[3224]: info: Install script completed Feb 21 23:59:27 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:27.555+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:27 rivo volumio[3224]: info: Adding reference to registry Feb 21 23:59:27 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:27.568+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:27 rivo volumio[3224]: info: Done installing plugin. Feb 21 23:59:27 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 23:59:27 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 23:59:27 rivo volumio[3224]: info: Folder /tmp/plugins removed Feb 21 23:59:27 rivo volumio[3224]: info: Folder /tmp/downloaded_plugin.zip removed Feb 21 23:59:27 rivo volumio[3224]: info: Folder /data/temp removed Feb 21 23:59:29 rivo ntpd[3458]: Soliciting pool server 31.58.102.164 Feb 21 23:59:29 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:30 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:32 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:34 rivo ntpd[3458]: Soliciting pool server 172.233.59.169 Feb 21 23:59:34 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:34 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:35 rivo volumio[3224]: info: Enabling plugin fusiondsp Feb 21 23:59:35 rivo volumio[3224]: info: Loading plugin "fusiondsp"... Feb 21 23:59:36 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 21 23:59:36 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 21 23:59:36 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 21 23:59:36 rivo volumio[3224]: info: Asound.conf file written Feb 21 23:59:36 rivo sudo[27019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 21 23:59:36 rivo sudo[27019]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:36 rivo sudo[27019]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:36 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 21 23:59:36 rivo kernel: Err: can not set rate to 4278967296! Feb 21 23:59:36 rivo kernel: Range[3920000 - 500000000] Feb 21 23:59:36 rivo kernel: out of value, fixed it Feb 21 23:59:36 rivo kernel: id=0 set inskew=0 Feb 21 23:59:36 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:36 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 21 23:59:36 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 21 23:59:36 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 21 23:59:36 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 21 23:59:36 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Feb 21 23:59:36 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 21 23:59:36 rivo sudo[27024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 23:59:36 rivo sudo[27024]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:36 rivo sudo[27024]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:36 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:36 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:36 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:36 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 21 23:59:36 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:36 rivo vtcs[30214]: [2026-02-21 23:59:36.718] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 21 23:59:36 rivo vtcs[30214]: [2026-02-21 23:59:36.722] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 21 23:59:36 rivo sudo[27027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 23:59:36 rivo sudo[27027]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:36 rivo volumio[3224]: info: PLUGIN START: fusiondsp Feb 21 23:59:36 rivo sudo[27030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:36 rivo volumio[3224]: info: Loading i18n strings for locale en Feb 21 23:59:36 rivo sudo[27030]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:36 rivo systemd[1]: Stopping Music Player Daemon... Feb 21 23:59:36 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 21 23:59:36 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:36 rivo volumio[3224]: info: FusionDsp - mixtype--------------------- None Feb 21 23:59:36 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 21 23:59:36 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Feb 21 23:59:36 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:36 rivo systemd[1]: vtcs.service: Succeeded. Feb 21 23:59:36 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Feb 21 23:59:36 rivo volumio[3224]: info: Done. Feb 21 23:59:36 rivo sudo[27030]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:36 rivo sudo[27034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:36 rivo sudo[27034]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:36 rivo sudo[27034]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:36 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 21 23:59:36 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 21 23:59:36 rivo volumio[3224]: info: Enabling plugin fusiondsp Feb 21 23:59:36 rivo volumio[3224]: info: Loading plugin "fusiondsp"... Feb 21 23:59:36 rivo volumio[3224]: info: Applying required configuration parameters for plugin fusiondsp Feb 21 23:59:36 rivo sudo[27043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 21 23:59:36 rivo sudo[27043]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:36 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:36 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:36 rivo sudo[27043]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo volumio[3224]: info: MPD Permissions set Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo sudo[27045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 21 23:59:37 rivo sudo[27045]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 23:59:37 rivo systemd[1]: mpd.service: Succeeded. Feb 21 23:59:37 rivo systemd[1]: Stopped Music Player Daemon. Feb 21 23:59:37 rivo qobuz-connect[30097]: 20260221 23:59:37.091 [30097.30097] INFO SampleApp: Stopping Local configuration server Feb 21 23:59:37 rivo systemd[1]: Starting Music Player Daemon... Feb 21 23:59:37 rivo qobuz-connect[30097]: 20260221 23:59:37.102 [30097.30097] INFO SampleApp: shat down connection on UNIX socket Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:37 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:37 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 21 23:59:37 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:37 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:37 rivo volumio[3224]: info: Asound.conf file unchanged, so no further update is needed Feb 21 23:59:37 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 21 23:59:37 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 21 23:59:37 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 21 23:59:37 rivo sudo[27045]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo sudo[27065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 23:59:37 rivo sudo[27054]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 23:59:37 rivo sudo[27065]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo sudo[27054]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:37 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:37 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo sudo[27065]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo sudo[27054]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo sudo[27071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 23:59:37 rivo sudo[27071]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 21 23:59:37 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:37 rivo systemd[1]: mpd.service: Succeeded. Feb 21 23:59:37 rivo systemd[1]: Stopped Music Player Daemon. Feb 21 23:59:37 rivo systemd[1]: Starting Music Player Daemon... Feb 21 23:59:37 rivo sudo[27075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:37 rivo sudo[27075]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo sudo[27075]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo sudo[27080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:37 rivo sudo[27080]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo sudo[27080]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo sudo[27089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 21 23:59:37 rivo sudo[27089]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo sudo[27076]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 23:59:37 rivo sudo[27076]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo sudo[27076]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo sudo[27089]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 21 23:59:37 rivo sudo[27093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 21 23:59:37 rivo sudo[27093]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 21 23:59:37 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:37 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 21 23:59:37 rivo systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Feb 21 23:59:37 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 21 23:59:37 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 21 23:59:37 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 21 23:59:37 rivo sudo[27093]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:37 rivo volumio[3224]: error: Upnp client error: Error: This socket has been ended by the other party Feb 21 23:59:37 rivo volumio[3224]: info: MPD Permissions set Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:37 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:37 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 21 23:59:37 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:37 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 21 23:59:37 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 21 23:59:37 rivo sudo[27114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 21 23:59:37 rivo sudo[27114]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:37 rivo sudo[27114]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.004 [27099.27099] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.023 [27099.27099] INFO VolumeManager: [0xab4296d0]: Setting new playback volume: 75 Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.023 [27099.27099] INFO VolumeManager: [0xab4296d0]: Setting new mute state: 0 Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.023 [27099.27099] INFO AudioStreamManager: [0xab429428]: Setting new audio download buffer size: 1048576 Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.023 [27099.27099] INFO QobuzConnect: [0xab429f98]: Client initialized! Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.023 [27099.27099] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 21 23:59:38 rivo sudo[27118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 21 23:59:38 rivo sudo[27118]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.041 [27099.27099] INFO LocalConfigManager: [0xab429150]: Starting Local Configuration server Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.041 [27099.27099] INFO SampleApp: Starting Local configuration server Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.042 [27099.27099] INFO SampleApp: Connected to UNIX socket client 0xab41eed8 Feb 21 23:59:38 rivo systemd[1]: Stopping RAAT DAEMON... Feb 21 23:59:38 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:38 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo systemd[1]: Stopped RAAT DAEMON. Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 23:59:38 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 21 23:59:38 rivo systemd[1]: Started RAAT DAEMON. Feb 21 23:59:38 rivo sudo[27118]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 21 23:59:38 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.154 [27099.27099] INFO SampleApp: Playback volume changed: 75 Feb 21 23:59:38 rivo volumio[3224]: info: Raat Daemon started successfully Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:38 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 21 23:59:38 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:38 rivo volumio[3224]: info: Asound.conf file unchanged, so no further update is needed Feb 21 23:59:38 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 21 23:59:38 rivo sudo[27134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 21 23:59:38 rivo sudo[27134]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo sudo[27134]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo sudo[27137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 23:59:38 rivo sudo[27137]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo sudo[27138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 21 23:59:38 rivo sudo[27137]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo sudo[27138]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:38 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:38 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo systemd[1]: Stopping RAAT DAEMON... Feb 21 23:59:38 rivo sudo[27142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 23:59:38 rivo sudo[27142]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:38 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 21 23:59:38 rivo systemd[1]: Stopped RAAT DAEMON. Feb 21 23:59:38 rivo systemd[1]: Started RAAT DAEMON. Feb 21 23:59:38 rivo sudo[27138]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo volumio[3224]: info: PLUGIN START: fusiondsp Feb 21 23:59:38 rivo volumio[3224]: info: Loading i18n strings for locale en Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:38 rivo volumio[3224]: info: FusionDsp - mixtype--------------------- None Feb 21 23:59:38 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 21 23:59:38 rivo sudo[27146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:38 rivo sudo[27146]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:38 rivo systemd[1]: mpd.service: Succeeded. Feb 21 23:59:38 rivo systemd[1]: Stopped Music Player Daemon. Feb 21 23:59:38 rivo systemd[1]: Starting Music Player Daemon... Feb 21 23:59:38 rivo volumio[3224]: info: Done. Feb 21 23:59:38 rivo sudo[27146]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo sudo[27159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:38 rivo sudo[27159]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo sudo[27159]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 21 23:59:38 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 21 23:59:38 rivo sudo[27152]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 23:59:38 rivo sudo[27152]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:38 rivo sudo[27152]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:38 rivo sudo[27167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 21 23:59:38 rivo sudo[27167]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:38 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:38 rivo volumio[3224]: info: MPD Permissions set Feb 21 23:59:38 rivo volumio[3224]: info: Raat Daemon started successfully Feb 21 23:59:38 rivo sudo[27167]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 21 23:59:38 rivo sudo[27171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 21 23:59:38 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:38 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.800 [27099.27099] INFO SampleApp: Stopping Local configuration server Feb 21 23:59:38 rivo qobuz-connect[27099]: 20260221 23:59:38.811 [27099.27099] INFO SampleApp: shat down connection on UNIX socket Feb 21 23:59:38 rivo sudo[27171]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:38 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 21 23:59:38 rivo sudo[27171]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:38 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 21 23:59:38 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 21 23:59:38 rivo volumio[3224]: info: camilladsp service started and running in background, instance 1 Feb 21 23:59:38 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:39 rivo volumio[3224]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Feb 21 23:59:39 rivo volumio[3224]: info: FusionDsp loaded Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 23:59:39 rivo sudo[27206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 21 23:59:39 rivo sudo[27206]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:39 rivo volumio[3224]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 21 23:59:39 rivo volumio[3224]: info: Adding Signal Path Element [object Object] Feb 21 23:59:39 rivo volumio[3224]: info: Adding fusiondspeq DSP Signal Path Element Feb 21 23:59:39 rivo volumio[3224]: info: Additional DSP elements updated Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:39 rivo volumio[3224]: info: FusionDsp - ---- installed callbackRead Feb 21 23:59:39 rivo volumio[3224]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 21 23:59:39 rivo systemd[1]: Started FusionDsp Daemon. Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo sudo[27206]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:39 rivo ntpd[3458]: Soliciting pool server 172.233.38.176 Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:39 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:39 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:39 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 21 23:59:39 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:39 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 23:59:39 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 21 23:59:39 rivo volumio[3224]: error: FusionDsp - WebSocket error: [object Object] Feb 21 23:59:39 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.577 [27175.27175] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.591 [27175.27175] INFO VolumeManager: [0xab53b6d0]: Setting new playback volume: 75 Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.592 [27175.27175] INFO VolumeManager: [0xab53b6d0]: Setting new mute state: 0 Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.592 [27175.27175] INFO AudioStreamManager: [0xab53b428]: Setting new audio download buffer size: 1048576 Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.593 [27175.27175] INFO QobuzConnect: [0xab53bf98]: Client initialized! Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.593 [27175.27175] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.613 [27175.27175] INFO LocalConfigManager: [0xab53b150]: Starting Local Configuration server Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.614 [27175.27175] INFO SampleApp: Starting Local configuration server Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.615 [27175.27175] INFO SampleApp: Connected to UNIX socket client 0xab530ed8 Feb 21 23:59:39 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Feb 21 23:59:39 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Feb 21 23:59:39 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 21 23:59:39 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 21 23:59:39 rivo qobuz-connect[27175]: 20260221 23:59:39.726 [27175.27175] INFO SampleApp: Playback volume changed: 75 Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 21 23:59:39 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:39 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:39 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:40 rivo volumio[3224]: info: Asound.conf file unchanged, so no further update is needed Feb 21 23:59:40 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 21 23:59:40 rivo sudo[27227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 21 23:59:40 rivo sudo[27227]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo sudo[27227]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo sudo[27230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 21 23:59:40 rivo sudo[27230]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo sudo[27231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 23:59:40 rivo sudo[27231]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo sudo[27231]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:40 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:40 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:40 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 21 23:59:40 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:40 rivo systemd[1]: Stopping RAAT DAEMON... Feb 21 23:59:40 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:40 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 21 23:59:40 rivo systemd[1]: Stopped RAAT DAEMON. Feb 21 23:59:40 rivo sudo[27235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 23:59:40 rivo sudo[27235]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo systemd[1]: Started RAAT DAEMON. Feb 21 23:59:40 rivo sudo[27230]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo sudo[27239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:40 rivo sudo[27239]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:40 rivo systemd[1]: mpd.service: Succeeded. Feb 21 23:59:40 rivo systemd[1]: Stopped Music Player Daemon. Feb 21 23:59:40 rivo sudo[27239]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo systemd[1]: Starting Music Player Daemon... Feb 21 23:59:40 rivo sudo[27253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:40 rivo sudo[27253]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo sudo[27253]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:40 rivo sudo[27252]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 23:59:40 rivo sudo[27264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 21 23:59:40 rivo sudo[27252]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo sudo[27264]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo sudo[27252]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo sudo[27264]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:40 rivo sudo[27268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 21 23:59:40 rivo sudo[27268]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:40 rivo qobuz-connect[27175]: 20260221 23:59:40.618 [27175.27175] INFO SampleApp: Stopping Local configuration server Feb 21 23:59:40 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 21 23:59:40 rivo qobuz-connect[27175]: 20260221 23:59:40.629 [27175.27175] INFO SampleApp: shat down connection on UNIX socket Feb 21 23:59:40 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 21 23:59:40 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 21 23:59:40 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 21 23:59:40 rivo sudo[27268]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:40 rivo volumio[3224]: 0+0 records in Feb 21 23:59:40 rivo volumio[3224]: 0+0 records out Feb 21 23:59:40 rivo volumio[3224]: 0 bytes copied, 0.00100534 s, 0.0 kB/s Feb 21 23:59:40 rivo volumio[3224]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 21 23:59:40 rivo volumio[3224]: 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 Feb 21 23:59:40 rivo volumio[3224]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 21 23:59:40 rivo volumio[3224]: info: camilladsp service started and running in background, instance 2 Feb 21 23:59:40 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:40 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:40 rivo volumio[3224]: cannot open device 'volumioHw': Device or resource busy Feb 21 23:59:40 rivo volumio[3224]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 21 23:59:40 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:40 rivo volumio[3224]: cannot open device 'volumioHw': Device or resource busy Feb 21 23:59:40 rivo volumio[3224]: info: FusionDsp loaded Feb 21 23:59:40 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 23:59:40 rivo volumio[3224]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 21 23:59:40 rivo volumio[3224]: info: Adding Signal Path Element [object Object] Feb 21 23:59:40 rivo volumio[3224]: info: Updating fusiondspeq DSP Signal Path Element Feb 21 23:59:40 rivo volumio[3224]: info: Additional DSP elements updated Feb 21 23:59:40 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:40 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:40 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:40 rivo volumio[3224]: info: FusionDsp - ---- installed callbackRead Feb 21 23:59:40 rivo volumio[3224]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 21 23:59:40 rivo sudo[27302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 21 23:59:40 rivo sudo[27302]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:41 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:41 rivo sudo[27302]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:41 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 21 23:59:41 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 21 23:59:41 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 21 23:59:41 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 21 23:59:41 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 21 23:59:41 rivo volumio[3224]: info: MPD Permissions set Feb 21 23:59:41 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 21 23:59:41 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:41 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:41 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:41 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:41 rivo volumio[3224]: info: Raat Daemon started successfully Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 21 23:59:41 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 21 23:59:41 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.451 [27276.27276] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.458 [27276.27276] INFO VolumeManager: [0xabe756d0]: Setting new playback volume: 75 Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.458 [27276.27276] INFO VolumeManager: [0xabe756d0]: Setting new mute state: 0 Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.458 [27276.27276] INFO AudioStreamManager: [0xabe75428]: Setting new audio download buffer size: 1048576 Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.458 [27276.27276] INFO QobuzConnect: [0xabe75f98]: Client initialized! Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.458 [27276.27276] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.476 [27276.27276] INFO LocalConfigManager: [0xabe75150]: Starting Local Configuration server Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.476 [27276.27276] INFO SampleApp: Starting Local configuration server Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.476 [27276.27276] INFO SampleApp: Connected to UNIX socket client 0xabe6aed8 Feb 21 23:59:41 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:41 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:41 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 21 23:59:41 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:41 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 21 23:59:41 rivo volumio[3224]: info: Reporting Headphone State: false Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo qobuz-connect[27276]: 20260221 23:59:41.601 [27276.27276] INFO SampleApp: Playback volume changed: 75 Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:41 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:41 rivo sudo[27336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 21 23:59:41 rivo sudo[27336]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:41 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Feb 21 23:59:41 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 21 23:59:41 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 21 23:59:41 rivo volumio[3224]: info: Starting Uninstall of plugin audio_interface - fusiondsp Feb 21 23:59:41 rivo volumio[3224]: info: Uninstalling plugin fusiondsp Feb 21 23:59:41 rivo volumio[3224]: info: FusionDsp - Stopping FusionDsp service Feb 21 23:59:41 rivo volumio[3224]: info: camilladsp stopping service pid 27319... Feb 21 23:59:41 rivo systemd[1]: Started Volumio Tidal Connect Service. Feb 21 23:59:41 rivo sudo[27336]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:41 rivo volumio[3224]: grep: /proc/27319/cmdline: No such file or directory Feb 21 23:59:41 rivo volumio[3224]: info: camilladsp service terminated, instance 2 Feb 21 23:59:41 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:41.750+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:41 rivo volumio[3224]: info: Disabling plugin fusiondsp Feb 21 23:59:41 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 21 23:59:41 rivo sudo[27345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Feb 21 23:59:41 rivo sudo[27345]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:41 rivo systemd[1]: Stopping FusionDsp Daemon... Feb 21 23:59:41 rivo volumio[27208]: Backend configuration: Feb 21 23:59:41 rivo volumio[27208]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Feb 21 23:59:41 rivo volumio[27208]: active_config_txt: null Feb 21 23:59:41 rivo volumio[27208]: camilla_host: 127.0.0.1 Feb 21 23:59:41 rivo volumio[27208]: camilla_port: 9876 Feb 21 23:59:41 rivo volumio[27208]: coeff_dir: /data/INTERNAL/FusionDsp/filters Feb 21 23:59:41 rivo volumio[27208]: config_dir: /data/configuration/audio_interface/fusiondsp Feb 21 23:59:41 rivo volumio[27208]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Feb 21 23:59:41 rivo volumio[27208]: log_file: /tmp/camilladsp.log Feb 21 23:59:41 rivo volumio[27208]: on_get_active_config: null Feb 21 23:59:41 rivo volumio[27208]: on_set_active_config: null Feb 21 23:59:41 rivo volumio[27208]: port: 5011 Feb 21 23:59:41 rivo volumio[27208]: supported_capture_types: null Feb 21 23:59:41 rivo volumio[27208]: supported_playback_types: null Feb 21 23:59:41 rivo volumio[27208]: update_config_symlink: false Feb 21 23:59:41 rivo volumio[27208]: update_config_txt: false Feb 21 23:59:41 rivo volumio[27208]: ======== Running on http://0.0.0.0:5011 ======== Feb 21 23:59:41 rivo volumio[27208]: (Press CTRL+C to quit) Feb 21 23:59:41 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:41 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:41 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:41 rivo sudo[27348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 21 23:59:41 rivo sudo[27348]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:41 rivo sudo[27348]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 23:59:41 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:42 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:42 rivo volumio[3224]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 21 23:59:42 rivo systemd[1]: fusiondsp.service: Succeeded. Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:42 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:42 rivo systemd[1]: Stopped FusionDsp Daemon. Feb 21 23:59:42 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:42 rivo sudo[27345]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 21 23:59:42 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:42 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 21 23:59:42 rivo volumio[3224]: info: Executing endpoint tc_getconfig Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 21 23:59:42 rivo sudo[27366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 21 23:59:42 rivo sudo[27366]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo vtcs[27339]: STARTING TidalConnect services, version: 1.6.1 Feb 21 23:59:42 rivo vtcs[27339]: STARTED TidalConnect services. Feb 21 23:59:42 rivo volumio[3224]: info: FusionDsp - Reporting Fusion DSP Disabled Feb 21 23:59:42 rivo volumio[3224]: info: Removing fusiondspeq DSP Signal Path Element Feb 21 23:59:42 rivo volumio[3224]: info: Additional DSP elements updated Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:42 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:42 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 21 23:59:42 rivo volumio[3224]: info: Reporting Headphone State: false Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:42 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:42 rivo sudo[27366]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:42 rivo sudo[27375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 21 23:59:42 rivo sudo[27375]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo volumio[3224]: info: Executing endpoint tc_connect Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 21 23:59:42 rivo systemd[1]: Stopping RAAT DAEMON... Feb 21 23:59:42 rivo volumio[3224]: info: Connecting to TidalConnect Feb 21 23:59:42 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:42 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 21 23:59:42 rivo systemd[1]: Stopped RAAT DAEMON. Feb 21 23:59:42 rivo systemd[1]: Started RAAT DAEMON. Feb 21 23:59:42 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:42 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:42 rivo sudo[27375]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:42 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:42 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::servicePushState Feb 21 23:59:42 rivo volumio[3224]: info: CoreStateMachine::pushState Feb 21 23:59:42 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::volumioPushState Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:42 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:42 rivo volumio[3224]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::servicePushState Feb 21 23:59:42 rivo volumio[3224]: info: CoreStateMachine::pushState Feb 21 23:59:42 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::volumioPushState Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:42 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:42 rivo volumio[3224]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 21 23:59:42 rivo volumio[3224]: info: Raat Daemon started successfully Feb 21 23:59:42 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:42 rivo volumio[3224]: info: Asound.conf file written Feb 21 23:59:42 rivo sudo[27395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 21 23:59:42 rivo sudo[27395]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo sudo[27395]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:42 rivo sudo[27403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 21 23:59:42 rivo sudo[27403]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo sudo[27403]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:42 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 21 23:59:42 rivo kernel: Err: can not set rate to 4274967296! Feb 21 23:59:42 rivo kernel: Range[3920000 - 500000000] Feb 21 23:59:42 rivo kernel: out of value, fixed it Feb 21 23:59:42 rivo kernel: id=0 set inskew=0 Feb 21 23:59:42 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:42 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 21 23:59:42 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 21 23:59:42 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 21 23:59:42 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 21 23:59:42 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Feb 21 23:59:42 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 21 23:59:42 rivo sudo[27409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 23:59:42 rivo sudo[27409]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo sudo[27409]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:42 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:42 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:42 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 21 23:59:42 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:42 rivo mpd[27273]: Feb 21 23:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 23:59:42 rivo vtcs[27339]: [2026-02-21 23:59:42.846] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 21 23:59:42 rivo vtcs[27339]: [2026-02-21 23:59:42.847] [tisoc] [error] [SpkconServer.cpp:383] recv error. client fd=7 errorno=104 error=Connection reset by peer Feb 21 23:59:42 rivo vtcs[27339]: [2026-02-21 23:59:42.847] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 21 23:59:42 rivo sudo[27412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 23:59:42 rivo sudo[27412]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:42.897+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:42 rivo volumio[3224]: info: Checking if uninstall.sh is present Feb 21 23:59:42 rivo sudo[27415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:42 rivo sudo[27415]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:42 rivo systemd[1]: mpd.service: Succeeded. Feb 21 23:59:42 rivo systemd[1]: Stopped Music Player Daemon. Feb 21 23:59:42 rivo systemd[1]: Starting Music Player Daemon... Feb 21 23:59:42 rivo sudo[27418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 21 23:59:42 rivo sudo[27418]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:42 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Feb 21 23:59:43 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:43 rivo systemd[1]: vtcs.service: Succeeded. Feb 21 23:59:43 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Feb 21 23:59:43 rivo sudo[27415]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:43 rivo sudo[27418]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:43 rivo sudo[27426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 21 23:59:43 rivo sudo[27426]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:43 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:43 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:43 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 21 23:59:43 rivo volumio[3224]: info: Executing uninstall.sh Feb 21 23:59:43 rivo sudo[27426]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:43 rivo sudo[27429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 21 23:59:43 rivo sudo[27429]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:43 rivo sudo[27419]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 23:59:43 rivo sudo[27419]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:43 rivo qobuz-connect[27276]: 20260221 23:59:43.181 [27276.27276] INFO SampleApp: Stopping Local configuration server Feb 21 23:59:43 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 21 23:59:43 rivo qobuz-connect[27276]: 20260221 23:59:43.192 [27276.27276] INFO SampleApp: shat down connection on UNIX socket Feb 21 23:59:43 rivo sudo[27419]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:43 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 21 23:59:43 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 21 23:59:43 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 21 23:59:43 rivo volumio[3224]: info: MPD Permissions set Feb 21 23:59:43 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:43 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:43 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:43 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 21 23:59:43 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:43 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:43 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 21 23:59:43 rivo volumio[3224]: info: Reporting Headphone State: false Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:43 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo sudo[27429]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:43 rivo sudo[27433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Feb 21 23:59:43 rivo sudo[27433]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 23:59:43 rivo sudo[27448]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /lib/systemd/system/fusiondsp.service Feb 21 23:59:43 rivo sudo[27448]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo sudo[27448]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:43 rivo sudo[27452]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 21 23:59:43 rivo sudo[27452]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:43 rivo systemd[1]: Reloading. Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 23:59:43 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 21 23:59:43 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 21 23:59:43 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.648 [27435.27435] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 21 23:59:43 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.654 [27435.27435] INFO VolumeManager: [0xac0966d0]: Setting new playback volume: 75 Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.655 [27435.27435] INFO VolumeManager: [0xac0966d0]: Setting new mute state: 0 Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.655 [27435.27435] INFO AudioStreamManager: [0xac096428]: Setting new audio download buffer size: 1048576 Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.655 [27435.27435] INFO QobuzConnect: [0xac096f98]: Client initialized! Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.655 [27435.27435] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 21 23:59:43 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.814 [27435.27435] INFO LocalConfigManager: [0xac096150]: Starting Local Configuration server Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.814 [27435.27435] INFO SampleApp: Starting Local configuration server Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.815 [27435.27435] INFO SampleApp: Connected to UNIX socket client 0xac08bed8 Feb 21 23:59:43 rivo qobuz-connect[27435]: 20260221 23:59:43.815 [27435.27435] INFO SampleApp: Playback volume changed: 75 Feb 21 23:59:43 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 21 23:59:43 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:43 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:43 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 21 23:59:44 rivo systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 21 23:59:44 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 21 23:59:44 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:44 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:44 rivo sudo[27486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 21 23:59:44 rivo sudo[27486]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:44 rivo sudo[27489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 21 23:59:44 rivo sudo[27489]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:44 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:44 rivo volumio[3224]: info: TidalConnect service started! Feb 21 23:59:44 rivo sudo[27452]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:44 rivo sudo[27433]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:44 rivo volumio[3224]: info: Uninstall script completed Feb 21 23:59:44 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:44.944+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:44 rivo volumio[3224]: info: Removing plugin fusiondsp from configuration Feb 21 23:59:44 rivo sudo[27486]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:44 rivo systemd[1]: Started Volumio Tidal Connect Service. Feb 21 23:59:45 rivo sudo[27489]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:45 rivo sudo[27491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 21 23:59:45 rivo sudo[27491]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:45 rivo systemd[1]: Stopping RAAT DAEMON... Feb 21 23:59:45 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 21 23:59:45 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 21 23:59:45 rivo systemd[1]: Stopped RAAT DAEMON. Feb 21 23:59:45 rivo systemd[1]: Started RAAT DAEMON. Feb 21 23:59:45 rivo sudo[27491]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:45 rivo mpd[27438]: Feb 21 23:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 23:59:45 rivo volumio[3224]: info: Successfully removed fusiondsp configuration files Feb 21 23:59:45 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:45.946+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:45 rivo volumio[3224]: info: Plugin folders cleanup Feb 21 23:59:45 rivo volumio[3224]: info: Scanning into folder /volumio/app/plugins/ Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category audio_interface Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category miscellanea Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category music_service Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category plugins.json Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category system_controller Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category user_interface Feb 21 23:59:45 rivo volumio[3224]: info: Scanning into folder /data/plugins/ Feb 21 23:59:45 rivo volumio[3224]: info: Scanning category audio_interface Feb 21 23:59:45 rivo volumio[3224]: info: Cleaning folder for fusiondsp Feb 21 23:59:46 rivo go-librespot[26998]: time="2026-02-21T23:59:46+01:00" level=trace msg="sent dealer ping" Feb 21 23:59:46 rivo go-librespot[26998]: time="2026-02-21T23:59:46+01:00" level=trace msg="received dealer pong" Feb 21 23:59:46 rivo volumio[3224]: info: Scanning category music_service Feb 21 23:59:46 rivo volumio[3224]: info: Scanning category user_interface Feb 21 23:59:46 rivo volumio[3224]: info: Plugin folders cleanup completed Feb 21 23:59:46 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:46.500+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 23:59:46 rivo volumio[3224]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.13","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.4.1","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Randomizer","name":"randomizer","category":"user_interface","version":"3.1.2","icon":"fa-random","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 23:59:46 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 21 23:59:46 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:46 rivo volumio[3224]: info: TidalConnect service stoped! Feb 21 23:59:46 rivo volumio[3224]: info: TidalConnect service started! Feb 21 23:59:46 rivo volumio[3224]: info: Raat Daemon started successfully Feb 21 23:59:46 rivo volumio[3224]: info: TidalConnect service started! Feb 21 23:59:46 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 21 23:59:46 rivo volumio[3224]: info: Executing endpoint tc_getconfig Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 21 23:59:46 rivo vtcs[27493]: STARTING TidalConnect services, version: 1.6.1 Feb 21 23:59:46 rivo vtcs[27493]: STARTED TidalConnect services. Feb 21 23:59:46 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 21 23:59:46 rivo volumio[3224]: info: Reporting Headphone State: false Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:46 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 21 23:59:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: Executing endpoint tc_connect Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 21 23:59:46 rivo volumio[3224]: info: Connecting to TidalConnect Feb 21 23:59:46 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:46 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 21 23:59:46 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::servicePushState Feb 21 23:59:46 rivo volumio[3224]: info: CoreStateMachine::pushState Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::volumioPushState Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::servicePushState Feb 21 23:59:46 rivo volumio[3224]: info: CoreStateMachine::pushState Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::volumioPushState Feb 21 23:59:46 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 21 23:59:46 rivo volumio[3224]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 21 23:59:46 rivo sudo[27529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 21 23:59:46 rivo sudo[27529]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:46 rivo sudo[27529]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:46 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:46 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:46 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:47 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 21 23:59:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 21 23:59:47 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 21 23:59:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 21 23:59:47 rivo volumio[3224]: info: Reporting Headphone State: false Feb 21 23:59:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 23:59:47 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 21 23:59:47 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:47 rivo systemd[1]: Started Music Player Daemon. Feb 21 23:59:47 rivo volumio[3224]: Upnp client error: Error: This socket has been ended by the other party Feb 21 23:59:47 rivo sudo[27071]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:47 rivo sudo[27412]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:47 rivo sudo[27142]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:47 rivo sudo[27027]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:47 rivo sudo[27235]: pam_unix(sudo:session): session closed for user root Feb 21 23:59:47 rivo volumio[3224]: error: MPD error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: MPD error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: MPD error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: MPD error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: The expression evaluated to a falsy value: Feb 21 23:59:47 rivo volumio[3224]: assert.ok(self.idling) Feb 21 23:59:47 rivo volumio[3224]: error: updateQueue error: null Feb 21 23:59:48 rivo volumio[3224]: info: TidalConnect service started! Feb 21 23:59:49 rivo volumio[3224]: info: TidalConnect service started! Feb 21 23:59:50 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:50 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:51 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 21 23:59:54 rivo volumio[3224]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/rivo/buster/armhf Feb 21 23:59:54 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:54.774+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:55 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 21 23:59:56 rivo volumio[3224]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/rivo/buster/armhf Feb 21 23:59:56 rivo volumio[3224]: info: Folder /tmp/plugins removed Feb 21 23:59:56 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:56.937+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:57 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:57.604+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:57 rivo volumio[3224]: info: Check plugin dependencies Feb 21 23:59:57 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 23:59:57 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:57.681+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:57 rivo volumio[3224]: info: Checking if plugin already exists Feb 21 23:59:57 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:57.687+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:57 rivo volumio[3224]: info: Rename folder Feb 21 23:59:57 rivo volumio[3224]: info: Folder /tmp/downloaded_plugin.zip removed Feb 21 23:59:57 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:57.745+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:57 rivo volumio[3224]: info: Move to category Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.157+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio[3224]: info: Checking if install.sh is present Feb 21 23:59:58 rivo volumio[3224]: info: Executing install.sh Feb 21 23:59:58 rivo sudo[27651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Feb 21 23:59:58 rivo sudo[27651]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:58 rivo volumio[3224]: info: creating filters folder and copying demo filters Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.325+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio[3224]: info: copying demo flters Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.385+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/ Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.509+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/2XEQ15/ Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.535+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/PEQ/ Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/convfir/ Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/convfir/kef.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/convfir/test.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/EQ15/ Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/EQ15/.Bass-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/EQ15/.Classic-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/EQ15/.Voice-FusionDsp.json Feb 21 23:59:58 rivo volumio[3224]: info: ./presets/EQ15/.Rock-FusionDsp.json Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.556+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.556+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.557+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.557+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.558+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.558+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.558+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.559+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.559+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.559+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.560+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.562+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.562+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.563+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.563+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo sudo[27676]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Feb 21 23:59:58 rivo sudo[27676]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 23:59:58 rivo volumio[3224]: info: Installing/fusiondsp dependencies Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.627+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:58 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 21 23:59:58 rivo volumio[3224]: info: Hit:1 http://archive.debian.org/debian buster InRelease Feb 21 23:59:58 rivo volumio5-onboarding[3599]: time=2026-02-21T23:59:58.900+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 21 23:59:59 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:03 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:05 rivo volumio[3224]: info: Reading package lists... Feb 22 00:00:05 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:05.098+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:05 rivo volumio[3224]: info: Building dependency tree... Feb 22 00:00:05 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:05.911+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:05 rivo volumio[3224]: info: Reading state information... Feb 22 00:00:05 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:05.922+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:05 rivo volumio[3224]: info: All packages are up to date. Feb 22 00:00:05 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:05.999+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:06 rivo sudo[27676]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:06 rivo sudo[27822]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Feb 22 00:00:06 rivo sudo[27822]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:06 rivo volumio[3224]: info: Reading package lists... Feb 22 00:00:06 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:06.221+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:06 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:06 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 22 00:00:06 rivo volumio[3224]: info: Building dependency tree... Feb 22 00:00:06 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:06.986+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:06 rivo volumio[3224]: info: Reading state information... Feb 22 00:00:06 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:06.997+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:07 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:08 rivo volumio[3224]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1). Feb 22 00:00:08 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:08.552+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:08 rivo sudo[27822]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:08 rivo volumio[3224]: info: python3-pip is already the newest version (18.1-5). Feb 22 00:00:08 rivo volumio[3224]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Feb 22 00:00:08 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:08.562+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:08 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:08.562+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:08 rivo sudo[27830]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Feb 22 00:00:08 rivo sudo[27830]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:08 rivo volumio[3224]: info: lib/systemd/system/fusiondsp.service Feb 22 00:00:08 rivo sudo[27830]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:08 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:08.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:10 rivo volumio[3224]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Feb 22 00:00:10 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:10.929+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:10 rivo volumio[3224]: info: more info at http://www.winimage.com/zLibDll/unzip.html Feb 22 00:00:10 rivo volumio[3224]: info: Feb 22 00:00:10 rivo volumio[3224]: info: cgui-1.0.0.zip opened Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/LICENSE.txt Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/README.md Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/build/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/robots.txt Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/logo512.png Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/asset-manifest.json Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/index.html Feb 22 00:00:10 rivo sudo[27855]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Feb 22 00:00:10 rivo sudo[27855]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/.put_statics_here Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/favicon.ico Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/logo192.png Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/manifest.json Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/css-variables.css Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/service-worker.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/build/static/ Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/build/static/css/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Feb 22 00:00:10 rivo sudo[27855]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/main.1503f6cd.css Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/build/static/media/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/build/static/js/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.71e11955.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Feb 22 00:00:10 rivo sudo[27857]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Feb 22 00:00:10 rivo sudo[27857]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.71e11955.js.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/config/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/config/camillagui.yml Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/config/gui-config.yml Feb 22 00:00:10 rivo volumio[3224]: info: creating directory: cgui/backend/ Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/backend/filters_test.py Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/backend/version.py Feb 22 00:00:10 rivo volumio[3224]: info: extracting: cgui/backend/filters.py Feb 22 00:00:10 rivo sudo[27857]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/settings.py Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/views.py Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/filterdefaults.py Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__init__.py Feb 22 00:00:11 rivo volumio[3224]: info: creating directory: cgui/backend/__pycache__/ Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/routes.py Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/backend/filemanagement.py Feb 22 00:00:11 rivo volumio[3224]: info: extracting: cgui/main.py Feb 22 00:00:11 rivo sudo[27859]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Feb 22 00:00:11 rivo sudo[27859]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:11 rivo sudo[27859]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.047+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.048+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.048+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.049+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.049+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.050+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.051+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.051+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.052+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.052+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.053+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.053+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.054+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.055+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.055+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.056+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.057+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.058+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.058+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.059+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.060+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.061+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.061+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.063+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.064+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.065+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.066+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.067+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.068+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.069+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.070+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.071+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.071+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.072+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.074+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.075+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.076+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.077+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.077+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.078+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.079+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.080+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.081+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.083+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.084+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.085+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.086+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.087+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.088+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.089+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.090+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.091+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.093+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.094+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.094+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:11.095+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:11 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:14 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:14 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 22 00:00:15 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:16 rivo go-librespot[26998]: time="2026-02-22T00:00:16+01:00" level=trace msg="sent dealer ping" Feb 22 00:00:16 rivo go-librespot[26998]: time="2026-02-22T00:00:16+01:00" level=trace msg="received dealer pong" Feb 22 00:00:17 rivo volumio[3224]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Feb 22 00:00:17 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:17.113+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:17 rivo volumio[3224]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-jmqdedqx Feb 22 00:00:17 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:17.130+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:17 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:19 rivo ntpd[3458]: Soliciting pool server 45.9.2.181 Feb 22 00:00:19 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:20 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:21 rivo volumio[3224]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp==1.0.0 from git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 in /usr/local/lib/python3.7/dist-packages Feb 22 00:00:21 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:21.273+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:21 rivo volumio[3224]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0.1) Feb 22 00:00:21 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:21.296+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:21 rivo volumio[3224]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.6.1) Feb 22 00:00:21 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:21.314+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:21 rivo volumio[3224]: info: Building wheels for collected packages: camilladsp Feb 22 00:00:21 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:21.357+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:21 rivo volumio[3224]: info: Running setup.py bdist_wheel for camilladsp: started Feb 22 00:00:21 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:21.375+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:22 rivo volumio[3224]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Feb 22 00:00:22 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:22.910+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:22 rivo volumio[3224]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-8s8sokqt/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Feb 22 00:00:22 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:22.926+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:22 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 22 00:00:22 rivo volumio[3224]: info: Successfully built camilladsp Feb 22 00:00:22 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:22.957+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:23 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:27 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:27 rivo systemd[1]: Starting Daily man-db regeneration... Feb 22 00:00:27 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:27 rivo systemd[1]: man-db.service: Succeeded. Feb 22 00:00:27 rivo systemd[1]: Started Daily man-db regeneration. Feb 22 00:00:28 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:30 rivo volumio[3224]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Feb 22 00:00:30 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:30.197+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:30 rivo volumio[3224]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-x9h8r_fc Feb 22 00:00:30 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:30.219+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:31 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 22 00:00:31 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:31 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.650+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.672+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3) Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.687+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3) Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.883+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.908+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10) Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.958+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:32 rivo volumio[3224]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0) Feb 22 00:00:32 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:32.978+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:33 rivo volumio[3224]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1) Feb 22 00:00:33 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:33.120+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:33 rivo volumio[3224]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0) Feb 22 00:00:33 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:33.139+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:33 rivo ntpd[3458]: Soliciting pool server 103.204.195.5 Feb 22 00:00:33 rivo volumio[3224]: info: Requirement already satisfied: zipp>=3.1.0; python_version < "3.10" in /usr/local/lib/python3.7/dist-packages (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) (3.15.0) Feb 22 00:00:33 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:33.324+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:33 rivo volumio[3224]: info: Building wheels for collected packages: camilladsp-plot Feb 22 00:00:33 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:33.469+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:33 rivo volumio[3224]: info: Running setup.py bdist_wheel for camilladsp-plot: started Feb 22 00:00:33 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:33.490+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:34 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:35 rivo volumio[3224]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Feb 22 00:00:35 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:35.074+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:35 rivo volumio[3224]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-rb7m4ylf/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Feb 22 00:00:35 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:35.090+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:35 rivo volumio[3224]: info: Successfully built camilladsp-plot Feb 22 00:00:35 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:35.140+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:35 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:35 rivo volumio[3224]: info: copying hw detection script Feb 22 00:00:35 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:35.730+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:35 rivo volumio[3224]: info: Detected cpu architecture as aarch64 Feb 22 00:00:35 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:35.752+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:36 rivo sudo[28021]: 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 Feb 22 00:00:36 rivo sudo[28021]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:37 rivo sudo[28021]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:37 rivo sudo[28023]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Feb 22 00:00:37 rivo sudo[28023]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:37 rivo sudo[28023]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:37 rivo sudo[28025]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Feb 22 00:00:37 rivo sudo[28025]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:37 rivo volumio[3224]: info: Reading package lists... Feb 22 00:00:37 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:37.226+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:38 rivo volumio[3224]: info: Building dependency tree... Feb 22 00:00:38 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:38.006+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:38 rivo volumio[3224]: info: Reading state information... Feb 22 00:00:38 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:38.024+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:39 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 22 00:00:39 rivo volumio[3224]: info: drc is already the newest version (3.2.2~dfsg0-2). Feb 22 00:00:39 rivo sudo[28025]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:39 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:39.589+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:39 rivo sudo[27651]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:39 rivo volumio[3224]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Feb 22 00:00:39 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:39.596+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:39 rivo volumio[3224]: info: Install script completed Feb 22 00:00:39 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:39.624+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:39 rivo volumio[3224]: info: Adding reference to registry Feb 22 00:00:39 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:39.637+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:39 rivo volumio[3224]: info: Done installing plugin. Feb 22 00:00:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 22 00:00:39 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 22 00:00:39 rivo volumio[3224]: info: Folder /tmp/plugins removed Feb 22 00:00:39 rivo volumio[3224]: info: Folder /tmp/downloaded_plugin.zip removed Feb 22 00:00:39 rivo volumio[3224]: Plugin install end detected on script Feb 22 00:00:39 rivo volumio[3224]: info: Folder /data/temp removed Feb 22 00:00:39 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:40 rivo ntpd[3458]: Soliciting pool server 185.51.192.61 Feb 22 00:00:42 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:43 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:44 rivo ntpd[3458]: Soliciting pool server 178.239.19.56 Feb 22 00:00:45 rivo volumio[3224]: info: Enabling plugin fusiondsp Feb 22 00:00:45 rivo volumio[3224]: info: Loading plugin "fusiondsp"... Feb 22 00:00:45 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 22 00:00:45 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 22 00:00:45 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 22 00:00:45 rivo volumio[3224]: info: Asound.conf file written Feb 22 00:00:45 rivo sudo[28063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 22 00:00:45 rivo sudo[28063]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo sudo[28063]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:45 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 22 00:00:45 rivo kernel: Err: can not set rate to 4270967296! Feb 22 00:00:45 rivo kernel: Range[3920000 - 500000000] Feb 22 00:00:45 rivo kernel: out of value, fixed it Feb 22 00:00:45 rivo kernel: id=0 set inskew=0 Feb 22 00:00:45 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:45 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 22 00:00:45 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 22 00:00:45 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 22 00:00:45 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 22 00:00:45 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Feb 22 00:00:45 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 22 00:00:45 rivo sudo[28068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 00:00:45 rivo sudo[28068]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo sudo[28068]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:45 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:45 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:45 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo vtcs[27493]: [2026-02-22 00:00:45.667] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 22 00:00:45 rivo vtcs[27493]: [2026-02-22 00:00:45.668] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 22 00:00:45 rivo sudo[28071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 00:00:45 rivo sudo[28071]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo volumio[3224]: info: PLUGIN START: fusiondsp Feb 22 00:00:45 rivo volumio[3224]: info: Loading i18n strings for locale en Feb 22 00:00:45 rivo systemd[1]: Stopping Music Player Daemon... Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo volumio[3224]: info: FusionDsp - mixtype--------------------- None Feb 22 00:00:45 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 22 00:00:45 rivo sudo[28074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:45 rivo sudo[28074]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo volumio[3224]: info: Done. Feb 22 00:00:45 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Feb 22 00:00:45 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:45 rivo systemd[1]: vtcs.service: Succeeded. Feb 22 00:00:45 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Feb 22 00:00:45 rivo sudo[28074]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:45 rivo sudo[28078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:45 rivo sudo[28078]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo sudo[28078]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:45 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 22 00:00:45 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 22 00:00:45 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:45 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:45 rivo sudo[28085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 22 00:00:45 rivo sudo[28085]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo volumio[3224]: info: MPD Permissions set Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:45 rivo sudo[28085]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:45 rivo sudo[28087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 22 00:00:45 rivo sudo[28087]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 00:00:45 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 22 00:00:46 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 22 00:00:46 rivo qobuz-connect[27435]: 20260222 00:00:46.006 [27435.27435] INFO SampleApp: Stopping Local configuration server Feb 22 00:00:46 rivo qobuz-connect[27435]: 20260222 00:00:46.017 [27435.27435] INFO SampleApp: shat down connection on UNIX socket Feb 22 00:00:46 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 22 00:00:46 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 22 00:00:46 rivo sudo[28087]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:46 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 22 00:00:46 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:46 rivo go-librespot[26998]: time="2026-02-22T00:00:46+01:00" level=trace msg="sent dealer ping" Feb 22 00:00:46 rivo volumio[3224]: info: Asound.conf file unchanged, so no further update is needed Feb 22 00:00:46 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 22 00:00:46 rivo systemd[1]: mpd.service: Succeeded. Feb 22 00:00:46 rivo systemd[1]: Stopped Music Player Daemon. Feb 22 00:00:46 rivo systemd[1]: Starting Music Player Daemon... Feb 22 00:00:46 rivo sudo[28102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 00:00:46 rivo sudo[28102]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:46 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:46 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo sudo[28102]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo sudo[28107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 00:00:46 rivo sudo[28107]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo go-librespot[26998]: time="2026-02-22T00:00:46+01:00" level=trace msg="received dealer pong" Feb 22 00:00:46 rivo sudo[28114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:46 rivo sudo[28114]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 22 00:00:46 rivo systemd[1]: mpd.service: Succeeded. Feb 22 00:00:46 rivo systemd[1]: Stopped Music Player Daemon. Feb 22 00:00:46 rivo systemd[1]: Starting Music Player Daemon... Feb 22 00:00:46 rivo sudo[28114]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo sudo[28117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:46 rivo sudo[28117]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo sudo[28117]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo sudo[28126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 22 00:00:46 rivo sudo[28126]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo sudo[28126]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 22 00:00:46 rivo volumio[3224]: error: Upnp client error: Error: This socket has been ended by the other party Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:46 rivo sudo[28132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 22 00:00:46 rivo sudo[28132]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo sudo[28118]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 00:00:46 rivo volumio[3224]: info: Enabling plugin fusiondsp Feb 22 00:00:46 rivo sudo[28118]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo volumio[3224]: info: Loading plugin "fusiondsp"... Feb 22 00:00:46 rivo volumio[3224]: info: Applying required configuration parameters for plugin fusiondsp Feb 22 00:00:46 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 22 00:00:46 rivo sudo[28118]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 22 00:00:46 rivo systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Feb 22 00:00:46 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 22 00:00:46 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 22 00:00:46 rivo volumio[3224]: info: MPD Permissions set Feb 22 00:00:46 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 22 00:00:46 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 22 00:00:46 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:46 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 22 00:00:46 rivo sudo[28132]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 22 00:00:46 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:46 rivo sudo[28149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 22 00:00:46 rivo sudo[28149]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo sudo[28149]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 00:00:46 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 22 00:00:46 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 22 00:00:46 rivo sudo[28155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 22 00:00:46 rivo sudo[28155]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:46 rivo systemd[1]: Stopping RAAT DAEMON... Feb 22 00:00:46 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:46 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 22 00:00:46 rivo systemd[1]: Stopped RAAT DAEMON. Feb 22 00:00:46 rivo systemd[1]: Started RAAT DAEMON. Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.930 [28135.28135] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.937 [28135.28135] INFO VolumeManager: [0xab6266d0]: Setting new playback volume: 75 Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.937 [28135.28135] INFO VolumeManager: [0xab6266d0]: Setting new mute state: 0 Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.937 [28135.28135] INFO AudioStreamManager: [0xab626428]: Setting new audio download buffer size: 1048576 Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.937 [28135.28135] INFO QobuzConnect: [0xab626f98]: Client initialized! Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.937 [28135.28135] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:46 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:46 rivo sudo[28155]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:46 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 22 00:00:46 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 22 00:00:46 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.981 [28135.28135] INFO LocalConfigManager: [0xab626150]: Starting Local Configuration server Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.981 [28135.28135] INFO SampleApp: Starting Local configuration server Feb 22 00:00:46 rivo qobuz-connect[28135]: 20260222 00:00:46.982 [28135.28135] INFO SampleApp: Connected to UNIX socket client 0xab61bed8 Feb 22 00:00:47 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:47 rivo qobuz-connect[28135]: 20260222 00:00:47.080 [28135.28135] INFO SampleApp: Playback volume changed: 75 Feb 22 00:00:47 rivo volumio[3224]: info: Raat Daemon started successfully Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:47 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:47 rivo volumio[3224]: info: Asound.conf file unchanged, so no further update is needed Feb 22 00:00:47 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 22 00:00:47 rivo sudo[28174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 22 00:00:47 rivo sudo[28174]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo sudo[28174]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo sudo[28177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 00:00:47 rivo sudo[28177]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo sudo[28177]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo sudo[28178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 22 00:00:47 rivo sudo[28178]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:47 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:47 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo sudo[28182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 00:00:47 rivo sudo[28182]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo systemd[1]: Stopping RAAT DAEMON... Feb 22 00:00:47 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:47 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 22 00:00:47 rivo systemd[1]: Stopped RAAT DAEMON. Feb 22 00:00:47 rivo volumio[3224]: info: PLUGIN START: fusiondsp Feb 22 00:00:47 rivo systemd[1]: Started RAAT DAEMON. Feb 22 00:00:47 rivo volumio[3224]: info: Loading i18n strings for locale en Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: FusionDsp - mixtype--------------------- None Feb 22 00:00:47 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 22 00:00:47 rivo sudo[28178]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo sudo[28186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:47 rivo sudo[28186]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo volumio[3224]: info: Done. Feb 22 00:00:47 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:47 rivo systemd[1]: mpd.service: Succeeded. Feb 22 00:00:47 rivo systemd[1]: Stopped Music Player Daemon. Feb 22 00:00:47 rivo systemd[1]: Starting Music Player Daemon... Feb 22 00:00:47 rivo sudo[28197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:47 rivo sudo[28186]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo sudo[28197]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo sudo[28197]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 22 00:00:47 rivo volumio[3224]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 22 00:00:47 rivo volumio[3224]: info: Reading ALSA contributions from plugins. Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:47 rivo sudo[28207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 22 00:00:47 rivo sudo[28207]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:47 rivo volumio[3224]: info: MPD Permissions set Feb 22 00:00:47 rivo volumio[3224]: info: Raat Daemon started successfully Feb 22 00:00:47 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.87 Feb 22 00:00:47 rivo sudo[28207]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo sudo[28209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 22 00:00:47 rivo sudo[28209]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo sudo[28198]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 00:00:47 rivo sudo[28198]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:47 rivo sudo[28198]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 22 00:00:47 rivo qobuz-connect[28135]: 20260222 00:00:47.613 [28135.28135] INFO SampleApp: Stopping Local configuration server Feb 22 00:00:47 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 22 00:00:47 rivo qobuz-connect[28135]: 20260222 00:00:47.623 [28135.28135] INFO SampleApp: shat down connection on UNIX socket Feb 22 00:00:47 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 22 00:00:47 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 22 00:00:47 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 22 00:00:47 rivo sudo[28209]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:47 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:47 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:47 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 22 00:00:47 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:47 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 22 00:00:47 rivo volumio[3224]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 22 00:00:47 rivo volumio[3224]: 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 Feb 22 00:00:47 rivo volumio[3224]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 22 00:00:47 rivo volumio[3224]: info: camilladsp service started and running in background, instance 3 Feb 22 00:00:47 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:47 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:47 rivo volumio[3224]: cannot open device 'volumioHw': Device or resource busy Feb 22 00:00:47 rivo volumio[3224]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 22 00:00:47 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:47 rivo volumio[3224]: cannot open device 'volumioHw': Device or resource busy Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp loaded Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 22 00:00:48 rivo volumio[3224]: info: Adding Signal Path Element [object Object] Feb 22 00:00:48 rivo volumio[3224]: info: Adding fusiondspeq DSP Signal Path Element Feb 22 00:00:48 rivo volumio[3224]: info: Additional DSP elements updated Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - ---- installed callbackRead Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 22 00:00:48 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.97 Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:48 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:48 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:48 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:48 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 22 00:00:48 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 22 00:00:48 rivo sudo[28266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 22 00:00:48 rivo sudo[28266]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo systemd[1]: Started FusionDsp Daemon. Feb 22 00:00:48 rivo sudo[28266]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.137 [28219.28219] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.147 [28219.28219] INFO VolumeManager: [0xab3ce6d0]: Setting new playback volume: 75 Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.156 [28219.28219] INFO VolumeManager: [0xab3ce6d0]: Setting new mute state: 0 Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.156 [28219.28219] INFO AudioStreamManager: [0xab3ce428]: Setting new audio download buffer size: 1048576 Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.156 [28219.28219] INFO QobuzConnect: [0xab3cef98]: Client initialized! Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.156 [28219.28219] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 22 00:00:48 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 22 00:00:48 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 22 00:00:48 rivo volumio[3224]: info: Asound.conf file unchanged, so no further update is needed Feb 22 00:00:48 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.184 [28219.28219] INFO LocalConfigManager: [0xab3ce150]: Starting Local Configuration server Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.184 [28219.28219] INFO SampleApp: Starting Local configuration server Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.185 [28219.28219] INFO SampleApp: Connected to UNIX socket client 0xab3c3ed8 Feb 22 00:00:48 rivo sudo[28293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 00:00:48 rivo sudo[28293]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo sudo[28293]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:48 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:48 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.287 [28219.28219] INFO SampleApp: Playback volume changed: 75 Feb 22 00:00:48 rivo sudo[28302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 00:00:48 rivo sudo[28302]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo sudo[28306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:48 rivo sudo[28306]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:48 rivo systemd[1]: mpd.service: Succeeded. Feb 22 00:00:48 rivo systemd[1]: Stopped Music Player Daemon. Feb 22 00:00:48 rivo sudo[28310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:48 rivo sudo[28310]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo systemd[1]: Starting Music Player Daemon... Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 22 00:00:48 rivo sudo[28306]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo sudo[28319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 22 00:00:48 rivo sudo[28319]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo sudo[28310]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo sudo[28319]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo sudo[28325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 22 00:00:48 rivo sudo[28325]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:48 rivo sudo[28314]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 00:00:48 rivo sudo[28314]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo sudo[28314]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.652 [28219.28219] INFO SampleApp: Stopping Local configuration server Feb 22 00:00:48 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 22 00:00:48 rivo qobuz-connect[28219]: 20260222 00:00:48.662 [28219.28219] INFO SampleApp: shat down connection on UNIX socket Feb 22 00:00:48 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 22 00:00:48 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 22 00:00:48 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Feb 22 00:00:48 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 22 00:00:48 rivo sudo[28325]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo volumio[3224]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:48 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:48 rivo sudo[28329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 22 00:00:48 rivo sudo[28329]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:48 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:48 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:48 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:48 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:48 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:48 rivo volumio[3224]: info: MPD Permissions set Feb 22 00:00:48 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 22 00:00:48 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:48 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:48 rivo sudo[28329]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo sudo[28333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 22 00:00:48 rivo sudo[28333]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:48 rivo systemd[1]: Stopping RAAT DAEMON... Feb 22 00:00:48 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:48 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 22 00:00:48 rivo systemd[1]: Stopped RAAT DAEMON. Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo systemd[1]: Started RAAT DAEMON. Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo sudo[28333]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 00:00:48 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:49 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:49 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:49 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.119 [28330.28330] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 22 00:00:49 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.128 [28330.28330] INFO VolumeManager: [0xac5926d0]: Setting new playback volume: 75 Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.129 [28330.28330] INFO VolumeManager: [0xac5926d0]: Setting new mute state: 0 Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.129 [28330.28330] INFO AudioStreamManager: [0xac592428]: Setting new audio download buffer size: 1048576 Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.130 [28330.28330] INFO QobuzConnect: [0xac592f98]: Client initialized! Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.131 [28330.28330] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 22 00:00:49 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 22 00:00:49 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 22 00:00:49 rivo volumio[3224]: info: Raat Daemon started successfully Feb 22 00:00:49 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.154 [28330.28330] INFO LocalConfigManager: [0xac592150]: Starting Local Configuration server Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.155 [28330.28330] INFO SampleApp: Starting Local configuration server Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.156 [28330.28330] INFO SampleApp: Connected to UNIX socket client 0xac587ed8 Feb 22 00:00:49 rivo volumio[3224]: 0+0 records in Feb 22 00:00:49 rivo volumio[3224]: 0+0 records out Feb 22 00:00:49 rivo volumio[3224]: 0 bytes copied, 0.000245793 s, 0.0 kB/s Feb 22 00:00:49 rivo qobuz-connect[28330]: 20260222 00:00:49.269 [28330.28330] INFO SampleApp: Playback volume changed: 75 Feb 22 00:00:49 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:49 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:49 rivo volumio[3224]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 22 00:00:49 rivo volumio[3224]: 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 Feb 22 00:00:49 rivo volumio[3224]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 22 00:00:49 rivo volumio[3224]: info: camilladsp service started and running in background, instance 4 Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:49 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:49 rivo volumio[3224]: cannot open device 'volumioHw': Device or resource busy Feb 22 00:00:49 rivo volumio[3224]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 22 00:00:49 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:49 rivo volumio[3224]: cannot open device 'volumioHw': Device or resource busy Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp loaded Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 22 00:00:49 rivo volumio[3224]: info: Adding Signal Path Element [object Object] Feb 22 00:00:49 rivo volumio[3224]: info: Updating fusiondspeq DSP Signal Path Element Feb 22 00:00:49 rivo volumio[3224]: info: Additional DSP elements updated Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:49 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - ---- installed callbackRead Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 22 00:00:49 rivo sudo[28412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 22 00:00:49 rivo sudo[28412]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:49 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 22 00:00:49 rivo sudo[28412]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:49 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:49 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:49 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:49 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:49 rivo volumio[3224]: info: FusionDsp - ---- read samplerate, raw: Feb 22 00:00:49 rivo volumio[3224]: error: FusionDsp - invalid sample rate Feb 22 00:00:49 rivo sudo[28417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 22 00:00:49 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:49 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:49 rivo sudo[28417]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:49 rivo sudo[28417]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:50 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:50 rivo sudo[28421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 22 00:00:50 rivo sudo[28421]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:50 rivo sudo[28422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 22 00:00:50 rivo sudo[28422]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:50 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:50 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 22 00:00:50 rivo systemd[1]: Started Volumio Tidal Connect Service. Feb 22 00:00:50 rivo systemd[1]: Stopping RAAT DAEMON... Feb 22 00:00:50 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:50 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 22 00:00:50 rivo systemd[1]: Stopped RAAT DAEMON. Feb 22 00:00:50 rivo sudo[28422]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:50 rivo systemd[1]: Started RAAT DAEMON. Feb 22 00:00:50 rivo sudo[28421]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:50 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:50 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:50 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:50 rivo volumio[3224]: info: Raat Daemon started successfully Feb 22 00:00:50 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 22 00:00:50 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 22 00:00:50 rivo volumio[3224]: info: Reporting Headphone State: false Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:50 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:50 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Feb 22 00:00:50 rivo volumio[3224]: info: Starting Uninstall of plugin audio_interface - fusiondsp Feb 22 00:00:50 rivo volumio[3224]: info: Uninstalling plugin fusiondsp Feb 22 00:00:50 rivo volumio[3224]: info: FusionDsp - Stopping FusionDsp service Feb 22 00:00:50 rivo volumio[3224]: info: camilladsp stopping service pid 28466... Feb 22 00:00:50 rivo volumio[3224]: info: camilladsp service terminated, instance 4 Feb 22 00:00:50 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:50.589+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:50 rivo volumio[3224]: info: Disabling plugin fusiondsp Feb 22 00:00:50 rivo volumio[3224]: info: Preparing to generate the ALSA configuration file Feb 22 00:00:50 rivo sudo[28478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Feb 22 00:00:50 rivo sudo[28478]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:50 rivo systemd[1]: Stopping FusionDsp Daemon... Feb 22 00:00:50 rivo volumio[28278]: Backend configuration: Feb 22 00:00:50 rivo volumio[28278]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Feb 22 00:00:50 rivo volumio[28278]: active_config_txt: null Feb 22 00:00:50 rivo volumio[28278]: camilla_host: 127.0.0.1 Feb 22 00:00:50 rivo volumio[28278]: camilla_port: 9876 Feb 22 00:00:50 rivo volumio[28278]: coeff_dir: /data/INTERNAL/FusionDsp/filters Feb 22 00:00:50 rivo volumio[28278]: config_dir: /data/configuration/audio_interface/fusiondsp Feb 22 00:00:50 rivo volumio[28278]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Feb 22 00:00:50 rivo volumio[28278]: log_file: /tmp/camilladsp.log Feb 22 00:00:50 rivo volumio[28278]: on_get_active_config: null Feb 22 00:00:50 rivo volumio[28278]: on_set_active_config: null Feb 22 00:00:50 rivo volumio[28278]: port: 5011 Feb 22 00:00:50 rivo volumio[28278]: supported_capture_types: null Feb 22 00:00:50 rivo volumio[28278]: supported_playback_types: null Feb 22 00:00:50 rivo volumio[28278]: update_config_symlink: false Feb 22 00:00:50 rivo volumio[28278]: update_config_txt: false Feb 22 00:00:50 rivo volumio[28278]: ======== Running on http://0.0.0.0:5011 ======== Feb 22 00:00:50 rivo volumio[28278]: (Press CTRL+C to quit) Feb 22 00:00:50 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:50 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:50 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:50 rivo volumio[3224]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 22 00:00:50 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:50 rivo sudo[28481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 22 00:00:50 rivo sudo[28481]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:50 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Feb 22 00:00:50 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 22 00:00:50 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:50 rivo sudo[28481]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:50 rivo volumio[3224]: info: Executing endpoint tc_getconfig Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 22 00:00:50 rivo vtcs[28430]: STARTING TidalConnect services, version: 1.6.1 Feb 22 00:00:50 rivo vtcs[28430]: STARTED TidalConnect services. Feb 22 00:00:50 rivo systemd[1]: fusiondsp.service: Succeeded. Feb 22 00:00:50 rivo systemd[1]: Stopped FusionDsp Daemon. Feb 22 00:00:50 rivo sudo[28478]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:50 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 22 00:00:50 rivo volumio[3224]: info: Reporting Headphone State: false Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:50 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:50 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:50 rivo volumio[3224]: info: FusionDsp - Reporting Fusion DSP Disabled Feb 22 00:00:50 rivo volumio[3224]: info: Removing fusiondspeq DSP Signal Path Element Feb 22 00:00:50 rivo volumio[3224]: info: Additional DSP elements updated Feb 22 00:00:50 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:50 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:51 rivo volumio[3224]: info: Executing endpoint tc_connect Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 22 00:00:51 rivo volumio[3224]: info: Connecting to TidalConnect Feb 22 00:00:51 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:51 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:51 rivo mpd[28332]: Feb 22 00:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 22 00:00:51 rivo volumio[3224]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Feb 22 00:00:51 rivo sudo[28515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 22 00:00:51 rivo sudo[28515]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::servicePushState Feb 22 00:00:51 rivo volumio[3224]: info: CoreStateMachine::pushState Feb 22 00:00:51 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::volumioPushState Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:51 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:51 rivo volumio[3224]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::servicePushState Feb 22 00:00:51 rivo volumio[3224]: info: CoreStateMachine::pushState Feb 22 00:00:51 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::volumioPushState Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:51 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:51 rivo volumio[3224]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 22 00:00:51 rivo sudo[28515]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo volumio[3224]: info: Asound.conf file written Feb 22 00:00:51 rivo sudo[28534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 22 00:00:51 rivo sudo[28534]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo sudo[28534]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 22 00:00:51 rivo kernel: Err: can not set rate to 4266967296! Feb 22 00:00:51 rivo kernel: Range[3920000 - 500000000] Feb 22 00:00:51 rivo kernel: out of value, fixed it Feb 22 00:00:51 rivo kernel: id=0 set inskew=0 Feb 22 00:00:51 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:51 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 22 00:00:51 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 22 00:00:51 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 22 00:00:51 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 22 00:00:51 rivo volumio[3224]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Feb 22 00:00:51 rivo volumio[3224]: info: Output device has changed, restarting MPD Feb 22 00:00:51 rivo sudo[28539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 00:00:51 rivo sudo[28539]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo sudo[28539]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:51 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:51 rivo volumio[3224]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:51 rivo vtcs[28430]: [2026-02-22 00:00:51.429] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 22 00:00:51 rivo vtcs[28430]: [2026-02-22 00:00:51.429] [tisoc] [error] [SpkconServer.cpp:383] recv error. client fd=8 errorno=104 error=Connection reset by peer Feb 22 00:00:51 rivo vtcs[28430]: [2026-02-22 00:00:51.429] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 22 00:00:51 rivo sudo[28542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 00:00:51 rivo sudo[28542]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:51.475+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:51 rivo volumio[3224]: info: Checking if uninstall.sh is present Feb 22 00:00:51 rivo sudo[28545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:51 rivo sudo[28545]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:51 rivo systemd[1]: mpd.service: Succeeded. Feb 22 00:00:51 rivo systemd[1]: Stopped Music Player Daemon. Feb 22 00:00:51 rivo sudo[28548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 00:00:51 rivo sudo[28548]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Feb 22 00:00:51 rivo systemd[1]: Starting Music Player Daemon... Feb 22 00:00:51 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:51 rivo systemd[1]: vtcs.service: Succeeded. Feb 22 00:00:51 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Feb 22 00:00:51 rivo sudo[28545]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo sudo[28548]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo sudo[28558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 22 00:00:51 rivo sudo[28558]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:51 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:51 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:51 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:51 rivo sudo[28558]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 22 00:00:51 rivo volumio[3224]: info: Executing uninstall.sh Feb 22 00:00:51 rivo sudo[28561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 22 00:00:51 rivo sudo[28561]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo sudo[28551]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 00:00:51 rivo sudo[28551]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo sudo[28551]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo volumio[3224]: info: MPD Permissions set Feb 22 00:00:51 rivo qobuz-connect[28330]: 20260222 00:00:51.814 [28330.28330] INFO SampleApp: Stopping Local configuration server Feb 22 00:00:51 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:51 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 22 00:00:51 rivo qobuz-connect[28330]: 20260222 00:00:51.825 [28330.28330] INFO SampleApp: shat down connection on UNIX socket Feb 22 00:00:51 rivo systemd[1]: qobuz-connect.service: Succeeded. Feb 22 00:00:51 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 22 00:00:51 rivo systemd[1]: Started Volumio Qobuz Connect Service. Feb 22 00:00:51 rivo sudo[28561]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:51 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:51 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.99 Feb 22 00:00:51 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:51 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:51 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 22 00:00:51 rivo volumio[3224]: info: QobuzConnect: setDeactiveState invoked Feb 22 00:00:51 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:51 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:51 rivo sudo[28566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Feb 22 00:00:51 rivo sudo[28566]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:51 rivo volumio[3224]: info: Discovery: Remote connection error: 192.168.1.141 Feb 22 00:00:52 rivo sudo[28585]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /lib/systemd/system/fusiondsp.service Feb 22 00:00:52 rivo sudo[28585]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo sudo[28585]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: Not Reporting Auto name since its the default one Feb 22 00:00:52 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 22 00:00:52 rivo volumio[3224]: info: Reporting Headphone State: false Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:52 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:52 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:52 rivo sudo[28590]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 22 00:00:52 rivo sudo[28590]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:52 rivo systemd[1]: Reloading. Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: Executing endpoint qc_getconfig Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.527 [28569.28569] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 22 00:00:52 rivo volumio[3224]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:52 rivo volumio[3224]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.534 [28569.28569] INFO VolumeManager: [0xac55a6d0]: Setting new playback volume: 75 Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.534 [28569.28569] INFO VolumeManager: [0xac55a6d0]: Setting new mute state: 0 Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.534 [28569.28569] INFO AudioStreamManager: [0xac55a428]: Setting new audio download buffer size: 1048576 Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.534 [28569.28569] INFO QobuzConnect: [0xac55af98]: Client initialized! Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.534 [28569.28569] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.553 [28569.28569] INFO LocalConfigManager: [0xac55a150]: Starting Local Configuration server Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.553 [28569.28569] INFO SampleApp: Starting Local configuration server Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.555 [28569.28569] INFO SampleApp: Connected to UNIX socket client 0xac54fed8 Feb 22 00:00:52 rivo volumio[3224]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 22 00:00:52 rivo volumio[3224]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 22 00:00:52 rivo sudo[28626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 22 00:00:52 rivo sudo[28626]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 22 00:00:52 rivo systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 22 00:00:52 rivo qobuz-connect[28569]: 20260222 00:00:52.677 [28569.28569] INFO SampleApp: Playback volume changed: 75 Feb 22 00:00:52 rivo volumio[3224]: xcb_connection_has_error() returned true Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::volumioGetState Feb 22 00:00:52 rivo volumio[3224]: info: CorePlayQueue::getTrack 0 Feb 22 00:00:52 rivo sudo[28638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 22 00:00:52 rivo sudo[28638]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:52 rivo volumio[3224]: info: RAAT: Requesting Headphone Status Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 22 00:00:52 rivo volumio[3224]: info: MCU Signalled Headphone Mode Disabled Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 22 00:00:52 rivo volumio[3224]: info: Reporting Headphone State: false Feb 22 00:00:52 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 00:00:52 rivo volumio[3224]: info: Updating RAAT Signal Path Feb 22 00:00:53 rivo volumio[3224]: info: TidalConnect service started! Feb 22 00:00:53 rivo sudo[28590]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:53 rivo sudo[28566]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:53 rivo volumio[3224]: info: Uninstall script completed Feb 22 00:00:53 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:53.611+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:53 rivo sudo[28638]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:53 rivo volumio[3224]: info: Removing plugin fusiondsp from configuration Feb 22 00:00:53 rivo systemd[1]: Started Volumio Tidal Connect Service. Feb 22 00:00:53 rivo sudo[28626]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:53 rivo systemd[1]: Starting Daily apt download activities... Feb 22 00:00:53 rivo sudo[28697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 22 00:00:53 rivo sudo[28697]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 00:00:53 rivo systemd[1]: Stopping RAAT DAEMON... Feb 22 00:00:53 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Feb 22 00:00:53 rivo systemd[1]: raat-daemon.service: Succeeded. Feb 22 00:00:53 rivo systemd[1]: Stopped RAAT DAEMON. Feb 22 00:00:53 rivo systemd[1]: Started RAAT DAEMON. Feb 22 00:00:53 rivo sudo[28697]: pam_unix(sudo:session): session closed for user root Feb 22 00:00:54 rivo volumio[3224]: info: Successfully removed fusiondsp configuration files Feb 22 00:00:54 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:54.029+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:54 rivo volumio[3224]: info: Plugin folders cleanup Feb 22 00:00:54 rivo volumio[3224]: info: Scanning into folder /volumio/app/plugins/ Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category audio_interface Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category miscellanea Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category music_service Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category plugins.json Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category system_controller Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category user_interface Feb 22 00:00:54 rivo volumio[3224]: info: Scanning into folder /data/plugins/ Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category audio_interface Feb 22 00:00:54 rivo volumio[3224]: info: Cleaning folder for fusiondsp Feb 22 00:00:54 rivo mpd[28567]: Feb 22 00:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category music_service Feb 22 00:00:54 rivo volumio[3224]: info: Scanning category user_interface Feb 22 00:00:54 rivo volumio[3224]: info: Plugin folders cleanup completed Feb 22 00:00:54 rivo volumio5-onboarding[3599]: time=2026-02-22T00:00:54.648+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 22 00:00:54 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 22 00:00:54 rivo volumio[3224]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.13","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.4.1","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Randomizer","name":"randomizer","category":"user_interface","version":"3.1.2","icon":"fa-random","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 22 00:00:54 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 22 00:00:54 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:54 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:54 rivo volumio[3224]: info: TidalConnect service started! Feb 22 00:00:54 rivo volumio[3224]: info: Raat Daemon started successfully Feb 22 00:00:54 rivo volumio[3224]: info: TidalConnect service started! Feb 22 00:00:54 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 22 00:00:54 rivo volumio[3224]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 22 00:00:54 rivo volumio[3224]: info: Executing endpoint restartRAATSocket Feb 22 00:00:54 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 22 00:00:54 rivo volumio[3224]: info: Executing endpoint tc_getconfig Feb 22 00:00:54 rivo volumio[3224]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 22 00:00:54 rivo volumio[3224]: info: TidalConnect service stoped! Feb 22 00:00:54 rivo vtcs[28698]: STARTING TidalConnect services, version: 1.6.1 Feb 22 00:00:54 rivo vtcs[28698]: STARTED TidalConnect services. Feb 22 00:00:54 rivo volumio[3224]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 00:00:54 rivo volumio[3224]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 22 00:00:54 rivo volumio[3224]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Feb 22 00:00:54 rivo volumio[3224]: at onErrorNT (internal/child_process.js:472:16) Feb 22 00:00:54 rivo volumio[3224]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Feb 22 00:00:54 rivo volumio[3224]: errno: -2, Feb 22 00:00:54 rivo volumio[3224]: code: 'ENOENT', Feb 22 00:00:54 rivo volumio[3224]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 22 00:00:54 rivo volumio[3224]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 22 00:00:54 rivo volumio[3224]: spawnargs: [ Feb 22 00:00:54 rivo volumio[3224]: '-p', Feb 22 00:00:54 rivo volumio[3224]: 9876, Feb 22 00:00:54 rivo volumio[3224]: '-o', Feb 22 00:00:54 rivo volumio[3224]: '/tmp/camilladsp.log', Feb 22 00:00:54 rivo volumio[3224]: '-l', Feb 22 00:00:54 rivo volumio[3224]: 'warn', Feb 22 00:00:54 rivo volumio[3224]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 22 00:00:54 rivo volumio[3224]: ] Feb 22 00:00:54 rivo volumio[3224]: } Feb 22 00:00:54 rivo volumio[3224]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 00:00:55 rivo sudo[28787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 23:59 Feb 22 00:00:55 rivo sudo[28787]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Feb 2026 12:38:21 PM CET" VOLUMIO_VERSION="3.911" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="26ab611a6c98e6eb78bedfbe8ab36cfa"