-- Logs begin at Thu 2025-04-17 17:02:12 CEST, end at Thu 2025-04-17 17:25:21 CEST. -- Apr 17 17:24:24 rivoplus volumio[3187]: info: Installing build dependencies: finished with status 'done' Apr 17 17:24:35 rivoplus volumio[3187]: info: Collecting websocket_client (from camilladsp==1.0.0) Apr 17 17:24:35 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Apr 17 17:24:35 rivoplus volumio[3187]: info: Building wheels for collected packages: camilladsp, PyYAML Apr 17 17:24:35 rivoplus volumio[3187]: info: Running setup.py bdist_wheel for camilladsp: started Apr 17 17:24:37 rivoplus volumio[3187]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Apr 17 17:24:37 rivoplus volumio[3187]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-190h0lwm/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Apr 17 17:24:37 rivoplus volumio[3187]: info: Running setup.py bdist_wheel for PyYAML: started Apr 17 17:24:40 rivoplus volumio[3187]: info: Running setup.py bdist_wheel for PyYAML: finished with status 'done' Apr 17 17:24:40 rivoplus volumio[3187]: info: Stored in directory: /root/.cache/pip/wheels/e6/c6/ef/4e8ee93f1b79fc90562f1600d47189799f8213023d9dadafa2 Apr 17 17:24:40 rivoplus volumio[3187]: info: Successfully built camilladsp PyYAML Apr 17 17:24:40 rivoplus volumio[3187]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Apr 17 17:24:41 rivoplus volumio[3187]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Apr 17 17:24:47 rivoplus volumio[3187]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Apr 17 17:24:47 rivoplus volumio[3187]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-15clawem Apr 17 17:24:50 rivoplus volumio[3187]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Apr 17 17:24:50 rivoplus volumio[3187]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Apr 17 17:24:51 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Apr 17 17:24:51 rivoplus volumio[3187]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Apr 17 17:24:52 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Apr 17 17:24:53 rivoplus volumio[3187]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Apr 17 17:24:53 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Apr 17 17:24:53 rivoplus volumio[3187]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Apr 17 17:24:53 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/64/de/375aa14daaee107f987da76ca32f7a907fea00fa8b8afb67dc09bec0de91/pyrsistent-0.19.3-py3-none-any.whl (57kB) Apr 17 17:24:54 rivoplus volumio[3187]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Apr 17 17:24:54 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Apr 17 17:24:55 rivoplus volumio[3187]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Apr 17 17:24:55 rivoplus volumio[3187]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Apr 17 17:24:55 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Apr 17 17:24:55 rivoplus volumio[3187]: info: Collecting zipp>=0.5 (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) Apr 17 17:24:56 rivoplus volumio[3187]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 17:24:56 rivoplus volumio[3187]: info: Discovery: Getting this device information Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 17:24:56 rivoplus volumio[3187]: info: Discovery: Getting this device information Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:24:56 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 17:24:56 rivoplus volumio[3187]: info: Building wheels for collected packages: camilladsp-plot Apr 17 17:24:56 rivoplus volumio[3187]: info: Running setup.py bdist_wheel for camilladsp-plot: started Apr 17 17:24:57 rivoplus volumio[3187]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Apr 17 17:24:57 rivoplus volumio[3187]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-faub4en3/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Apr 17 17:24:57 rivoplus volumio[3187]: info: Successfully built camilladsp-plot Apr 17 17:24:58 rivoplus volumio[3187]: info: Installing collected packages: zipp, typing-extensions, importlib-metadata, pkgutil-resolve-name, pyrsistent, importlib-resources, jsonschema, camilladsp-plot Apr 17 17:24:59 rivoplus volumio[3187]: 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 Apr 17 17:25:00 rivoplus volumio[3187]: verbose: New Socket.io Connection to 192.168.178.25:3000 from 192.168.178.74 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Apr 17 17:25:00 rivoplus volumio[3187]: info: copying hw detection script Apr 17 17:25:00 rivoplus volumio[3187]: info: Detected cpu architecture as aarch64 Apr 17 17:25:01 rivoplus volumio[3187]: info: camilladsp Apr 17 17:25:01 rivoplus sudo[10041]: 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 Apr 17 17:25:01 rivoplus sudo[10041]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:02 rivoplus sudo[10041]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:02 rivoplus sudo[10043]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Apr 17 17:25:02 rivoplus sudo[10043]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:02 rivoplus sudo[10043]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:02 rivoplus sudo[10045]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Apr 17 17:25:02 rivoplus sudo[10045]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:02 rivoplus volumio[3187]: info: Reading package lists... Apr 17 17:25:02 rivoplus volumio[3187]: verbose: New Socket.io Connection to 192.168.178.25 from 192.168.178.74 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Apr 17 17:25:02 rivoplus volumio[3187]: info: Received Get System Info Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 17:25:02 rivoplus volumio[3187]: info: Discovery: Getting this device information Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetVisibleSources Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 17 17:25:02 rivoplus volumio[3187]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 17 17:25:02 rivoplus volumio[3187]: info: Received Get System Info Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 17:25:02 rivoplus volumio[3187]: info: Discovery: Getting this device information Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetState Apr 17 17:25:02 rivoplus volumio[3187]: info: Listing playlists Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::volumioGetQueue Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreStateMachine::getQueue Apr 17 17:25:02 rivoplus volumio[3187]: info: CorePlayQueue::getQueue Apr 17 17:25:02 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 17 17:25:02 rivoplus volumio[3187]: info: Building dependency tree... Apr 17 17:25:03 rivoplus volumio[3187]: info: Reading state information... Apr 17 17:25:04 rivoplus volumio[3187]: info: The following NEW packages will be installed: Apr 17 17:25:04 rivoplus volumio[3187]: info: drc Apr 17 17:25:04 rivoplus volumio[3187]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Apr 17 17:25:04 rivoplus volumio[3187]: info: Need to get 118 kB of archives. Apr 17 17:25:04 rivoplus volumio[3187]: info: After this operation, 471 kB of additional disk space will be used. Apr 17 17:25:04 rivoplus volumio[3187]: info: Get:1 http://deb.debian.org/debian buster/main armhf drc armhf 3.2.2~dfsg0-2 [118 kB] Apr 17 17:25:05 rivoplus volumio[3187]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf Apr 17 17:25:06 rivoplus volumio[3187]: info: Fetched 118 kB in 0s (918 kB/s) Apr 17 17:25:06 rivoplus volumio[3187]: info: Selecting previously unselected package drc. Apr 17 17:25:07 rivoplus volumio[3187]: [620B blob data] Apr 17 17:25:07 rivoplus volumio[3187]: info: Preparing to unpack .../drc_3.2.2~dfsg0-2_armhf.deb ... Apr 17 17:25:07 rivoplus volumio[3187]: info: Unpacking drc (3.2.2~dfsg0-2) ... Apr 17 17:25:07 rivoplus volumio[3187]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf Apr 17 17:25:07 rivoplus volumio[3187]: info: Folder /tmp/plugins removed Apr 17 17:25:08 rivoplus volumio[3187]: info: Setting up drc (3.2.2~dfsg0-2) ... Apr 17 17:25:08 rivoplus volumio[3187]: info: Processing triggers for man-db (2.8.5-2) ... Apr 17 17:25:08 rivoplus volumio[3187]: info: Check plugin dependencies Apr 17 17:25:08 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 17 17:25:08 rivoplus volumio[3187]: info: Checking if plugin already exists Apr 17 17:25:08 rivoplus volumio[3187]: info: Rename folder Apr 17 17:25:08 rivoplus volumio[3187]: info: Move to category Apr 17 17:25:08 rivoplus volumio[3187]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 17:25:09 rivoplus sudo[10045]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:09 rivoplus sudo[8175]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:09 rivoplus volumio[3187]: info: Checking if install.sh is present Apr 17 17:25:09 rivoplus volumio[3187]: info: Executing install.sh Apr 17 17:25:09 rivoplus volumio[3187]: info: Install script completed Apr 17 17:25:09 rivoplus volumio[3187]: info: Adding reference to registry Apr 17 17:25:10 rivoplus volumio[3187]: info: Done installing plugin. Apr 17 17:25:10 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 17 17:25:10 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 17 17:25:10 rivoplus volumio[3187]: Plugin install end detected on script Apr 17 17:25:10 rivoplus volumio[3187]: info: Folder /tmp/plugins removed Apr 17 17:25:10 rivoplus volumio[3187]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 17:25:10 rivoplus volumio[3187]: info: Folder /data/temp removed Apr 17 17:25:10 rivoplus sudo[10142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Apr 17 17:25:10 rivoplus sudo[10142]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:10 rivoplus volumio[3187]: info: creating filters folder and copying demo filters Apr 17 17:25:10 rivoplus volumio[3187]: info: copying demo flters Apr 17 17:25:10 rivoplus volumio[3187]: info: Installing/fusiondsp dependencies Apr 17 17:25:10 rivoplus sudo[10163]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Apr 17 17:25:10 rivoplus sudo[10163]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:10 rivoplus volumio[3187]: info: Hit:1 http://deb.debian.org/debian buster InRelease Apr 17 17:25:10 rivoplus volumio[3187]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Apr 17 17:25:14 rivoplus volumio[3187]: info: CorePlayQueue::getTrack 2 Apr 17 17:25:14 rivoplus volumio[3187]: info: CorePlayQueue::getTrack 3 Apr 17 17:25:14 rivoplus volumio[3187]: info: Prefetching next song Apr 17 17:25:14 rivoplus volumio[3187]: info: [1744903514720] ControllerTidal::prefetch Apr 17 17:25:14 rivoplus volumio[3187]: info: Getting stream with soundQuality HI_RES Apr 17 17:25:14 rivoplus volumio[3187]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/118916354&soundQuality=HI_RES" Apr 17 17:25:14 rivoplus volumio[3187]: info: Apr 17 17:25:14 rivoplus volumio[3187]: ---------------------------- MPD announces system playlist update Apr 17 17:25:14 rivoplus volumio[3187]: info: Ignoring MPD Status Update Apr 17 17:25:14 rivoplus volumio[3187]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/118916354&soundQuality=HI_RES" took 4 milliseconds Apr 17 17:25:14 rivoplus volumio[3187]: STREAMING PROXY: Handling url /?data=tidal://song/118916354&soundQuality=HI_RES Apr 17 17:25:14 rivoplus volumio[3187]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 17 17:25:14 rivoplus volumio[3187]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 17 17:25:14 rivoplus volumio[3187]: info: ------------------------------ 7ms Apr 17 17:25:14 rivoplus volumio[3187]: info: sendMpdCommand consume 1 took 3 milliseconds Apr 17 17:25:14 rivoplus volumio[3187]: info: Executing endpoint getStreamUrltidal Apr 17 17:25:14 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Apr 17 17:25:15 rivoplus volumio[3187]: info: getStreamUrl took 261 milliseconds Apr 17 17:25:15 rivoplus volumio[3187]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidiNGZkZDJhMDRhNTA5Zjg1M2ViMDEzOTk0NTQwOWQ0NF82MS5tcDQ/0.flac?Expires=1744907114&Signature=fUiAJ77L8OVTDQzGk~g4UFXe8Nbm0DoMJjfv9BP8t6Q14ZMLb6MP3iEMiFJYLbyOpAJ~ABn-xSjiioOR8ieFF44qlHneMcEsCKy~lgbG6pVwPC1h~M4m9vGeEXYeptiRm4aE9TK4-Of6LyrafDwl~vkkDM9ETWoFXJf7RP-3DOhud8CySR8QEIgb-Gc4XnYIb6dQR4S8itznmLDn1GVEoCuJlJBeZ0vlSNBC2C6~XI2dl7NZRfJGxhh-DBpFtAhpMsNfw7RLuiqZaSnNwW90C6aRVMjnc0A-Bg4kymeOMJlJ3rtgzMd~MrrE4Px-Djrndi2z2PiKf~Y8oEb4-zt-zg__&Key-Pair-Id=K14LZCZ9QUI4JL Apr 17 17:25:15 rivoplus volumio[3187]: STREAMING PROXY: Response: 200, length: 27306829 Apr 17 17:25:15 rivoplus volumio[3187]: STREAMING PROXY: Client dropped request, destroying Apr 17 17:25:16 rivoplus volumio[3187]: info: Enabling plugin fusiondsp Apr 17 17:25:16 rivoplus volumio[3187]: info: Loading plugin "fusiondsp"... Apr 17 17:25:17 rivoplus volumio[3187]: info: Preparing to generate the ALSA configuration file Apr 17 17:25:17 rivoplus volumio[3187]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 17 17:25:17 rivoplus volumio[3187]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 17 17:25:17 rivoplus volumio[3187]: info: Reading ALSA contributions from plugins. Apr 17 17:25:17 rivoplus volumio[3187]: info: Reading package lists... Apr 17 17:25:17 rivoplus volumio[3187]: info: Asound.conf file written Apr 17 17:25:17 rivoplus sudo[10407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 17 17:25:17 rivoplus sudo[10407]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus sudo[10407]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:17 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994 Apr 17 17:25:17 rivoplus kernel: Err: can not set rate to 4278967296! Apr 17 17:25:17 rivoplus kernel: Range[3920000 - 500000000] Apr 17 17:25:17 rivoplus kernel: out of value, fixed it Apr 17 17:25:17 rivoplus kernel: id=0 set inskew=0 Apr 17 17:25:17 rivoplus volumio[3187]: No protocol specified Apr 17 17:25:17 rivoplus volumio[3187]: xcb_connection_has_error() returned true Apr 17 17:25:17 rivoplus volumio[3187]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Apr 17 17:25:17 rivoplus volumio[3187]: Hardware is initialized using a generic method Apr 17 17:25:17 rivoplus volumio[3187]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Apr 17 17:25:17 rivoplus volumio[3187]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Apr 17 17:25:17 rivoplus volumio[3187]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Apr 17 17:25:17 rivoplus volumio[3187]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Apr 17 17:25:17 rivoplus volumio[3187]: No state is present for card DACZ8 Apr 17 17:25:17 rivoplus volumio[3187]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:30fd" "" "" Apr 17 17:25:17 rivoplus volumio[3187]: Hardware is initialized using a generic method Apr 17 17:25:17 rivoplus volumio[3187]: No state is present for card DACZ8 Apr 17 17:25:17 rivoplus volumio[3187]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Apr 17 17:25:17 rivoplus volumio[3187]: info: Output device has changed, restarting MPD Apr 17 17:25:17 rivoplus sudo[10412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 17 17:25:17 rivoplus sudo[10412]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus volumio[3187]: info: Output device has changed, restarting Shairport Sync Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 17:25:17 rivoplus sudo[10412]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:17 rivoplus sudo[10415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 17 17:25:17 rivoplus sudo[10415]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus systemd[1]: Stopping Music Player Daemon... Apr 17 17:25:17 rivoplus volumio[3187]: No protocol specified Apr 17 17:25:17 rivoplus volumio[3187]: xcb_connection_has_error() returned true Apr 17 17:25:17 rivoplus volumio[3187]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 17 17:25:17 rivoplus volumio[3187]: No protocol specified Apr 17 17:25:17 rivoplus volumio[3187]: xcb_connection_has_error() returned true Apr 17 17:25:17 rivoplus volumio[3187]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus systemd[1]: mpd.service: Succeeded. Apr 17 17:25:17 rivoplus systemd[1]: Stopped Music Player Daemon. Apr 17 17:25:17 rivoplus volumio[3187]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus systemd[1]: Starting Music Player Daemon... Apr 17 17:25:17 rivoplus vtcs[5774]: [2025-04-17 17:25:17.503] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 17 17:25:17 rivoplus vtcs[5774]: [2025-04-17 17:25:17.509] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 17 17:25:17 rivoplus vtcs[5774]: [2025-04-17 17:25:17.509] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Apr 17 17:25:17 rivoplus volumio[3187]: info: PLUGIN START: fusiondsp Apr 17 17:25:17 rivoplus volumio[3187]: info: Loading i18n strings for locale de Apr 17 17:25:17 rivoplus sudo[10431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 17 17:25:17 rivoplus sudo[10431]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: FusionDsp - mixtype--------------------- None Apr 17 17:25:17 rivoplus volumio[3187]: info: Preparing to generate the ALSA configuration file Apr 17 17:25:17 rivoplus sudo[10163]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:17 rivoplus volumio[3187]: info: Done. Apr 17 17:25:17 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Apr 17 17:25:17 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 17 17:25:17 rivoplus systemd[1]: vtcs.service: Succeeded. Apr 17 17:25:17 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Apr 17 17:25:17 rivoplus sudo[10434]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Apr 17 17:25:17 rivoplus sudo[10431]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:17 rivoplus sudo[10434]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus volumio[3187]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 17 17:25:17 rivoplus volumio[3187]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 17 17:25:17 rivoplus volumio[3187]: info: Reading ALSA contributions from plugins. Apr 17 17:25:17 rivoplus volumio[3187]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 17 17:25:17 rivoplus volumio[3187]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 17 17:25:17 rivoplus volumio[3187]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 17 17:25:17 rivoplus sudo[10423]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 17 17:25:17 rivoplus sudo[10423]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus volumio[3187]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 17 17:25:17 rivoplus sudo[10438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 17 17:25:17 rivoplus sudo[10438]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus sudo[10423]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 17:25:17 rivoplus volumio[3187]: info: MPD Permissions set Apr 17 17:25:17 rivoplus volumio[3187]: info: Building dependency tree... Apr 17 17:25:17 rivoplus volumio[3187]: info: Reading state information... Apr 17 17:25:17 rivoplus volumio[3187]: info: All packages are up to date. Apr 17 17:25:17 rivoplus sudo[10438]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 17 17:25:17 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:19 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:19 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 17 17:25:19 rivoplus volumio[3187]: info: Not Reporting Auto name since its the default one Apr 17 17:25:20 rivoplus mpd[10445]: Apr 17 17:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 17 17:25:20 rivoplus systemd[1]: Started Music Player Daemon. Apr 17 17:25:20 rivoplus sudo[10415]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:20 rivoplus volumio[3187]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Apr 17 17:25:20 rivoplus volumio[3187]: info: camilladsp service started and running in background, instance 1 Apr 17 17:25:20 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:20 rivoplus volumio[3187]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 17 17:25:20 rivoplus volumio[3187]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 17 17:25:20 rivoplus volumio[3187]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 17 17:25:20 rivoplus volumio[3187]: info: FusionDsp loaded Apr 17 17:25:20 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 17:25:20 rivoplus sudo[10472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 17 17:25:20 rivoplus sudo[10472]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:20 rivoplus systemd[1]: Started FusionDsp Daemon. Apr 17 17:25:20 rivoplus sudo[10472]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:20 rivoplus volumio[3187]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 17 17:25:20 rivoplus volumio[3187]: info: Adding Signal Path Element [object Object] Apr 17 17:25:20 rivoplus volumio[3187]: info: Adding fusiondspeq DSP Signal Path Element Apr 17 17:25:20 rivoplus volumio[3187]: info: Additional DSP elements updated Apr 17 17:25:20 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:20 rivoplus volumio[3187]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 17:25:20 rivoplus volumio[3187]: info: Updating RAAT Signal Path Apr 17 17:25:20 rivoplus volumio[3187]: info: FusionDsp - ---- installed callbackRead Apr 17 17:25:20 rivoplus volumio[3187]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 17:25:20 rivoplus volumio[3187]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 17 17:25:20 rivoplus volumio[3187]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Apr 17 17:25:20 rivoplus volumio[3187]: at onErrorNT (internal/child_process.js:472:16) Apr 17 17:25:20 rivoplus volumio[3187]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 17 17:25:20 rivoplus volumio[3187]: at runNextTicks (internal/process/task_queues.js:64:3) Apr 17 17:25:20 rivoplus volumio[3187]: at listOnTimeout (internal/timers.js:526:9) Apr 17 17:25:20 rivoplus volumio[3187]: at processTimers (internal/timers.js:500:7) { Apr 17 17:25:20 rivoplus volumio[3187]: errno: -2, Apr 17 17:25:20 rivoplus volumio[3187]: code: 'ENOENT', Apr 17 17:25:20 rivoplus volumio[3187]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 17 17:25:20 rivoplus volumio[3187]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 17 17:25:20 rivoplus volumio[3187]: spawnargs: [ Apr 17 17:25:20 rivoplus volumio[3187]: '-p', Apr 17 17:25:20 rivoplus volumio[3187]: 9876, Apr 17 17:25:20 rivoplus volumio[3187]: '-o', Apr 17 17:25:20 rivoplus volumio[3187]: '/tmp/camilladsp.log', Apr 17 17:25:20 rivoplus volumio[3187]: '-l', Apr 17 17:25:20 rivoplus volumio[3187]: 'warn', Apr 17 17:25:20 rivoplus volumio[3187]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 17 17:25:20 rivoplus volumio[3187]: ] Apr 17 17:25:20 rivoplus volumio[3187]: } Apr 17 17:25:20 rivoplus volumio[3187]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 17:25:20 rivoplus sudo[10434]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:20 rivoplus sudo[10478]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Apr 17 17:25:20 rivoplus sudo[10478]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 17:25:20 rivoplus volumio[10474]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Apr 17 17:25:20 rivoplus sudo[10478]: pam_unix(sudo:session): session closed for user root Apr 17 17:25:20 rivoplus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Apr 17 17:25:20 rivoplus systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 17 17:25:21 rivoplus sudo[10489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-17 17:24 Apr 17 17:25:21 rivoplus sudo[10489]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:42:11 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="4f5519a96ae5ba7dcfda362cc37343d4"