-- Logs begin at Mon 2025-11-10 20:08:57 CET, end at Fri 2025-12-12 19:21:47 CET. --
Dec 12 19:20:30 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 12 19:20:30 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 12 19:20:30 rivoplus volumio[3725]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:20:43 rivoplus volumio[3725]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf
Dec 12 19:21:01 rivoplus volumio[3725]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivoplus/buster/armhf
Dec 12 19:21:01 rivoplus volumio[3725]: info: FusionDsp - Stopping FusionDsp service
Dec 12 19:21:01 rivoplus volumio[3725]: info: camilladsp stopping service pid 9628...
Dec 12 19:21:01 rivoplus volumio[3725]: info: camilladsp service terminated, instance 1
Dec 12 19:21:01 rivoplus sudo[10557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service
Dec 12 19:21:01 rivoplus sudo[10557]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:01 rivoplus systemd[1]: Stopping FusionDsp Daemon...
Dec 12 19:21:01 rivoplus volumio[4118]: Backend configuration:
Dec 12 19:21:01 rivoplus volumio[4118]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Dec 12 19:21:01 rivoplus volumio[4118]: active_config_txt: null
Dec 12 19:21:01 rivoplus volumio[4118]: camilla_host: 127.0.0.1
Dec 12 19:21:01 rivoplus volumio[4118]: camilla_port: 9876
Dec 12 19:21:01 rivoplus volumio[4118]: coeff_dir: /data/INTERNAL/FusionDsp/filters
Dec 12 19:21:01 rivoplus volumio[4118]: config_dir: /data/configuration/audio_interface/fusiondsp
Dec 12 19:21:01 rivoplus volumio[4118]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Dec 12 19:21:01 rivoplus volumio[4118]: log_file: /tmp/camilladsp.log
Dec 12 19:21:01 rivoplus volumio[4118]: on_get_active_config: null
Dec 12 19:21:01 rivoplus volumio[4118]: on_set_active_config: null
Dec 12 19:21:01 rivoplus volumio[4118]: port: 5011
Dec 12 19:21:01 rivoplus volumio[4118]: supported_capture_types: null
Dec 12 19:21:01 rivoplus volumio[4118]: supported_playback_types: null
Dec 12 19:21:01 rivoplus volumio[4118]: update_config_symlink: false
Dec 12 19:21:01 rivoplus volumio[4118]: update_config_txt: false
Dec 12 19:21:01 rivoplus volumio[4118]: ======== Running on http://0.0.0.0:5011 ========
Dec 12 19:21:01 rivoplus volumio[4118]: (Press CTRL+C to quit)
Dec 12 19:21:01 rivoplus systemd[1]: fusiondsp.service: Succeeded.
Dec 12 19:21:01 rivoplus systemd[1]: Stopped FusionDsp Daemon.
Dec 12 19:21:01 rivoplus sudo[10557]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:01 rivoplus volumio[3725]: info: FusionDsp - Reporting Fusion DSP Disabled
Dec 12 19:21:01 rivoplus volumio[3725]: info: Removing fusiondspeq DSP Signal Path Element
Dec 12 19:21:01 rivoplus volumio[3725]: info: Check plugin dependencies
Dec 12 19:21:01 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 12 19:21:01 rivoplus volumio[3725]: info: Rename folder
Dec 12 19:21:01 rivoplus volumio[3725]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 12 19:21:01 rivoplus volumio[3725]: info: Move to category
Dec 12 19:21:01 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 12 19:21:01 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 12 19:21:02 rivoplus volumio[3725]: info: Checking if install.sh is present
Dec 12 19:21:02 rivoplus volumio[3725]: info: Executing install.sh
Dec 12 19:21:02 rivoplus sudo[10578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh
Dec 12 19:21:02 rivoplus sudo[10578]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:02 rivoplus volumio[3725]: info: creating filters folder and copying demo filters
Dec 12 19:21:02 rivoplus sudo[10592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 12 19:21:02 rivoplus sudo[10592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:02 rivoplus volumio[3725]: info: copying demo flters
Dec 12 19:21:02 rivoplus sudo[10592]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:02 rivoplus sudo[10597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 12 19:21:02 rivoplus sudo[10597]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:02 rivoplus sudo[10597]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:02 rivoplus volumio[3725]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.11 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Pro Build/BP3A.251005.004.B2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.174 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Dec 12 19:21:02 rivoplus volumio[3725]: info: Installing/fusiondsp dependencies
Dec 12 19:21:02 rivoplus sudo[10607]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update
Dec 12 19:21:02 rivoplus sudo[10607]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:02 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 12 19:21:02 rivoplus sudo[10612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 12 19:21:02 rivoplus sudo[10612]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:02 rivoplus sudo[10612]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:02 rivoplus sudo[10616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 12 19:21:02 rivoplus sudo[10616]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:02 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 12 19:21:02 rivoplus sudo[10616]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:03 rivoplus volumio[3725]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.11 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Pro Build/BP3A.251005.004.B2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.174 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 12 19:21:03 rivoplus volumio[3725]: info: Received Get System Info
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:21:03 rivoplus volumio[3725]: info: Discovery: Getting this device information
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:03 rivoplus volumio[3725]: info: Listing playlists
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:21:03 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 12 19:21:03 rivoplus volumio[3725]: info: Hit:1 http://archive.debian.org/debian buster InRelease
Dec 12 19:21:03 rivoplus volumio[3725]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease
Dec 12 19:21:04 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Dec 12 19:21:04 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 12 19:21:04 rivoplus volumio[3725]: info: Received Get System Info
Dec 12 19:21:04 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:21:04 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:21:04 rivoplus volumio[3725]: info: Discovery: Getting this device information
Dec 12 19:21:04 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:04 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:21:05 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 12 19:21:05 rivoplus volumio[3725]: info: Received Get System Info
Dec 12 19:21:05 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:21:05 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:21:05 rivoplus volumio[3725]: info: Discovery: Getting this device information
Dec 12 19:21:05 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:05 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:21:08 rivoplus volumio[3725]: info: Reading package lists...
Dec 12 19:21:09 rivoplus volumio[3725]: info: Building dependency tree...
Dec 12 19:21:09 rivoplus volumio[3725]: info: Reading state information...
Dec 12 19:21:09 rivoplus volumio[3725]: info: All packages are up to date.
Dec 12 19:21:09 rivoplus sudo[10607]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:09 rivoplus sudo[10872]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip
Dec 12 19:21:09 rivoplus sudo[10872]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:10 rivoplus volumio[3725]: info: Reading package lists...
Dec 12 19:21:10 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 12 19:21:10 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 12 19:21:10 rivoplus volumio[3725]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:21:10 rivoplus volumio[3725]: info: Building dependency tree...
Dec 12 19:21:10 rivoplus volumio[3725]: info: Reading state information...
Dec 12 19:21:12 rivoplus volumio[3725]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1).
Dec 12 19:21:12 rivoplus sudo[10872]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:12 rivoplus volumio[3725]: info: python3-pip is already the newest version (18.1-5).
Dec 12 19:21:12 rivoplus volumio[3725]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
Dec 12 19:21:12 rivoplus sudo[10880]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C /
Dec 12 19:21:12 rivoplus sudo[10880]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:12 rivoplus volumio[3725]: info: lib/systemd/system/fusiondsp.service
Dec 12 19:21:12 rivoplus sudo[10880]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:13 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Dec 12 19:21:18 rivoplus volumio[3725]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant
Dec 12 19:21:18 rivoplus volumio[3725]: info: more info at http://www.winimage.com/zLibDll/unzip.html
Dec 12 19:21:18 rivoplus volumio[3725]: info:
Dec 12 19:21:18 rivoplus volumio[3725]: info: cgui-1.0.0.zip opened
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/LICENSE.txt
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/README.md
Dec 12 19:21:18 rivoplus sudo[10896]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui
Dec 12 19:21:18 rivoplus sudo[10896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/build/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/robots.txt
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/logo512.png
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/asset-manifest.json
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/index.html
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/.put_statics_here
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/favicon.ico
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/logo192.png
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/manifest.json
Dec 12 19:21:18 rivoplus sudo[10896]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/css-variables.css
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/service-worker.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/build/static/
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/build/static/css/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/main.1503f6cd.css
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/build/static/media/
Dec 12 19:21:18 rivoplus sudo[10898]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg
Dec 12 19:21:18 rivoplus sudo[10898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/build/static/js/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.71e11955.js
Dec 12 19:21:18 rivoplus sudo[10898]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.71e11955.js.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/config/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/config/camillagui.yml
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX
Dec 12 19:21:18 rivoplus sudo[10900]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/config/gui-config.yml
Dec 12 19:21:18 rivoplus sudo[10900]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/backend/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/filters_test.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/version.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/filters.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/settings.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/views.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/filterdefaults.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__init__.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: creating directory: cgui/backend/__pycache__/
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc
Dec 12 19:21:18 rivoplus sudo[10900]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/routes.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/backend/filemanagement.py
Dec 12 19:21:18 rivoplus volumio[3725]: info: extracting: cgui/main.py
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 12 19:21:21 rivoplus volumio[3725]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Dec 12 19:21:21 rivoplus volumio[3725]: info: Received Get System Version
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 12 19:21:21 rivoplus volumio[3725]: info: Received Get System Info
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:21:21 rivoplus volumio[3725]: info: Discovery: Getting this device information
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:21 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:21:24 rivoplus volumio[3725]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0
Dec 12 19:21:24 rivoplus volumio[3725]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-ht43_f2q
Dec 12 19:21:30 rivoplus volumio[3725]: 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
Dec 12 19:21:30 rivoplus volumio[3725]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0.1)
Dec 12 19:21:30 rivoplus volumio[3725]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.6.1)
Dec 12 19:21:30 rivoplus volumio[3725]: info: Building wheels for collected packages: camilladsp
Dec 12 19:21:30 rivoplus volumio[3725]: info: Running setup.py bdist_wheel for camilladsp: started
Dec 12 19:21:32 rivoplus volumio[3725]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done'
Dec 12 19:21:32 rivoplus volumio[3725]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-0av1cleu/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6
Dec 12 19:21:32 rivoplus volumio[3725]: info: Successfully built camilladsp
Dec 12 19:21:33 rivoplus volumio[3725]: info: CorePlayQueue::getTrack 0
Dec 12 19:21:33 rivoplus volumio[3725]: info: CorePlayQueue::getTrack 1
Dec 12 19:21:33 rivoplus volumio[3725]: info: Prefetching next song
Dec 12 19:21:33 rivoplus volumio[3725]: info: [1765563693542] ControllerQobuz::prefetch
Dec 12 19:21:33 rivoplus volumio[3725]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/711271"
Dec 12 19:21:33 rivoplus volumio[3725]: STREAMING PROXY: Handling url /?data=qobuz://song/711271
Dec 12 19:21:33 rivoplus volumio[3725]: info: Executing endpoint getStreamUrlqobuz
Dec 12 19:21:33 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Dec 12 19:21:33 rivoplus volumio[3725]: info: getStreamUrl took 416 milliseconds
Dec 12 19:21:33 rivoplus volumio[3725]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3571284&eid=711271&fmt=6&profile=raw&app_id=539451548&cid=3108765&etsp=1765567293&hmac=CVp_gCD1WB2vFvAnQ021I8kWBcs
Dec 12 19:21:34 rivoplus volumio[3725]: STREAMING PROXY: Response: 200, length: 20016824
Dec 12 19:21:34 rivoplus volumio[3725]: STREAMING PROXY: Client dropped request, destroying
Dec 12 19:21:34 rivoplus volumio[3725]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/711271"
Dec 12 19:21:34 rivoplus volumio[3725]: info:
Dec 12 19:21:34 rivoplus volumio[3725]: ---------------------------- MPD announces system playlist update
Dec 12 19:21:34 rivoplus volumio[3725]: info: Ignoring MPD Status Update
Dec 12 19:21:34 rivoplus volumio[3725]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/711271" took 3 milliseconds
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 19:21:34 rivoplus volumio[3725]: verbose: ControllerMpd::sendMpdCommand consume 1
Dec 12 19:21:34 rivoplus volumio[3725]: info:
Dec 12 19:21:34 rivoplus volumio[3725]: ---------------------------- MPD announces state update: options
Dec 12 19:21:34 rivoplus volumio[3725]: info: ------------------------------ 5ms
Dec 12 19:21:34 rivoplus volumio[3725]: info: sendMpdCommand consume 1 took 3 milliseconds
Dec 12 19:21:34 rivoplus volumio[3725]: info: ControllerMpd::getState
Dec 12 19:21:34 rivoplus volumio[3725]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 19:21:34 rivoplus volumio[3725]: info: sendMpdCommand status took 1 milliseconds
Dec 12 19:21:34 rivoplus volumio[3725]: verbose: ControllerMpd::parseState
Dec 12 19:21:34 rivoplus volumio[3725]: info: ControllerMpd::pushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::servicePushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreStateMachine::pushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::volumioPushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CorePlayQueue::getTrack 0
Dec 12 19:21:34 rivoplus volumio[3725]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 12 19:21:34 rivoplus volumio[3725]: verbose: CURRENT POSITION 0
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreStateMachine::syncState stateService stop
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreStateMachine::syncState currentStatus play
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreStateMachine::pushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::volumioPushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreStateMachine::pushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::volumioPushState
Dec 12 19:21:34 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:34 rivoplus volumio[3725]: info: ------------------------------ 64ms
Dec 12 19:21:34 rivoplus volumio[3725]: info: Signalling Playback active due to playback status change
Dec 12 19:21:34 rivoplus volumio[3725]: info: MCU Signalled Playback Inactive
Dec 12 19:21:39 rivoplus volumio[3725]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2
Dec 12 19:21:39 rivoplus volumio[3725]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-0vag2_cb
Dec 12 19:21:42 rivoplus volumio[3725]: 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
Dec 12 19:21:42 rivoplus volumio[3725]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1)
Dec 12 19:21:42 rivoplus volumio[3725]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3)
Dec 12 19:21:42 rivoplus volumio[3725]: 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)
Dec 12 19:21:42 rivoplus volumio[3725]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0)
Dec 12 19:21:42 rivoplus volumio[3725]: 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)
Dec 12 19:21:42 rivoplus volumio[3725]: 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)
Dec 12 19:21:42 rivoplus volumio[3725]: 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)
Dec 12 19:21:43 rivoplus volumio[3725]: 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)
Dec 12 19:21:43 rivoplus volumio[3725]: info: Requirement already satisfied: zipp>=0.5 in /usr/local/lib/python3.7/dist-packages (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) (3.15.0)
Dec 12 19:21:43 rivoplus volumio[3725]: info: Building wheels for collected packages: camilladsp-plot
Dec 12 19:21:43 rivoplus volumio[3725]: info: Running setup.py bdist_wheel for camilladsp-plot: started
Dec 12 19:21:43 rivoplus volumio[3725]: info: Enabling plugin fusiondsp
Dec 12 19:21:43 rivoplus volumio[3725]: info: Loading plugin "fusiondsp"...
Dec 12 19:21:43 rivoplus volumio[3725]: info: Applying required configuration parameters for plugin fusiondsp
Dec 12 19:21:44 rivoplus volumio[3725]: info: Preparing to generate the ALSA configuration file
Dec 12 19:21:44 rivoplus volumio[3725]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Dec 12 19:21:44 rivoplus volumio[3725]: info: Reading ALSA contributions from plugins.
Dec 12 19:21:44 rivoplus volumio[3725]: info: Asound.conf file unchanged, so no further update is needed
Dec 12 19:21:44 rivoplus volumio[3725]: info: Output device has changed, restarting MPD
Dec 12 19:21:44 rivoplus sudo[11097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 12 19:21:44 rivoplus sudo[11097]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus volumio[3725]: info: Output device has changed, restarting Shairport Sync
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 12 19:21:44 rivoplus sudo[11097]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:44 rivoplus sudo[11100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 12 19:21:44 rivoplus sudo[11100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus systemd[1]: Stopping Music Player Daemon...
Dec 12 19:21:44 rivoplus volumio[3725]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 12 19:21:44 rivoplus systemd[1]: mpd.service: Succeeded.
Dec 12 19:21:44 rivoplus volumio[3725]: info: QobuzConnect: setDeactiveState invoked
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:44 rivoplus systemd[1]: Stopped Music Player Daemon.
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: PLUGIN START: fusiondsp
Dec 12 19:21:44 rivoplus systemd[1]: Starting Music Player Daemon...
Dec 12 19:21:44 rivoplus volumio[3725]: info: Loading i18n strings for locale it
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: FusionDsp - mixtype--------------------- undefined
Dec 12 19:21:44 rivoplus volumio[3725]: info: Preparing to generate the ALSA configuration file
Dec 12 19:21:44 rivoplus volumio[3725]: info: Done.
Dec 12 19:21:44 rivoplus volumio[3725]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Dec 12 19:21:44 rivoplus volumio[3725]: info: Reading ALSA contributions from plugins.
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:21:44 rivoplus volumio[3725]: info: MPD Permissions set
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus sudo[11120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 12 19:21:44 rivoplus sudo[11109]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 12 19:21:44 rivoplus sudo[11120]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus sudo[11109]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus sudo[11109]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:44 rivoplus sudo[11120]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 12 19:21:44 rivoplus sudo[11128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 12 19:21:44 rivoplus sudo[11128]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus qobuz-connect[4101]: 20251212 19:21:44.482 [4101.4101] INFO ContentFetcher: [0xabc39458]: Canceling download
Dec 12 19:21:44 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service...
Dec 12 19:21:44 rivoplus qobuz-connect[4101]: 20251212 19:21:44.484 [4101.4101] INFO CloudClient: [0xab9d8a60]: Disconnecting from the cloud
Dec 12 19:21:44 rivoplus qobuz-connect[4101]: 20251212 19:21:44.484 [4101.4101] INFO CloudClient: [0xab9d8a60]: Connection closed
Dec 12 19:21:44 rivoplus qobuz-connect[4101]: 20251212 19:21:44.549 [4101.4101] INFO SampleApp: Stopping Local configuration server
Dec 12 19:21:44 rivoplus qobuz-connect[4101]: 20251212 19:21:44.550 [4101.4101] INFO SampleApp: shat down connection on UNIX socket
Dec 12 19:21:44 rivoplus systemd[1]: qobuz-connect.service: Succeeded.
Dec 12 19:21:44 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service.
Dec 12 19:21:44 rivoplus systemd[1]: Started Volumio Qobuz Connect Service.
Dec 12 19:21:44 rivoplus sudo[11128]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:44 rivoplus volumio[3725]: error: Upnp client error: Error: This socket has been ended by the other party
Dec 12 19:21:44 rivoplus volumio[3725]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Dec 12 19:21:44 rivoplus volumio[3725]: info: QobuzConnect: setDeactiveState invoked
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:44 rivoplus volumio[3725]: info: Starting Shairport Sync
Dec 12 19:21:44 rivoplus volumio[3725]: info: Executing endpoint qc_getconfig
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.852 [11133.11133] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.863 [11133.11133] INFO VolumeManager: [0xaaece8f0]: Setting new playback volume: 75
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.863 [11133.11133] INFO VolumeManager: [0xaaece8f0]: Setting new mute state: 0
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.863 [11133.11133] INFO QobuzConnect: [0xaaecf2c0]: Client initialized!
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.863 [11133.11133] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp
Dec 12 19:21:44 rivoplus sudo[11137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 12 19:21:44 rivoplus volumio[3725]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Dec 12 19:21:44 rivoplus volumio[3725]: info: QobuzConnect: QOBUZ Connect daemon connected
Dec 12 19:21:44 rivoplus volumio[3725]: info: Asound.conf file unchanged, so no further update is needed
Dec 12 19:21:44 rivoplus sudo[11137]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus volumio[3725]: info: Output device has changed, restarting MPD
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.888 [11133.11133] INFO LocalConfigManager: [0xaaece1d0]: Starting Local Configuration server
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.888 [11133.11133] INFO SampleApp: Starting Local configuration server
Dec 12 19:21:44 rivoplus qobuz-connect[11133]: 20251212 19:21:44.889 [11133.11133] INFO SampleApp: Connected to UNIX socket client 0xaaec3ed8
Dec 12 19:21:44 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 12 19:21:44 rivoplus systemd[1]: shairport-sync.service: Succeeded.
Dec 12 19:21:44 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 12 19:21:44 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 12 19:21:44 rivoplus sudo[11137]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:44 rivoplus volumio[3725]: info: Output device has changed, restarting Shairport Sync
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:44 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 12 19:21:44 rivoplus sudo[11141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 12 19:21:44 rivoplus sudo[11141]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:44 rivoplus sudo[11144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 12 19:21:44 rivoplus sudo[11144]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:45 rivoplus qobuz-connect[11133]: 20251212 19:21:45.002 [11133.11133] INFO SampleApp: Playback volume changed: 75
Dec 12 19:21:45 rivoplus sudo[11141]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:45 rivoplus volumio[3725]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 12 19:21:45 rivoplus volumio[3725]: info: QobuzConnect: setDeactiveState invoked
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Dec 12 19:21:45 rivoplus systemd[1]: mpd.service: Succeeded.
Dec 12 19:21:45 rivoplus systemd[1]: Stopped Music Player Daemon.
Dec 12 19:21:45 rivoplus systemd[1]: Starting Music Player Daemon...
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:45 rivoplus volumio[3725]: info: MPD Permissions set
Dec 12 19:21:45 rivoplus volumio[3725]: info: Shairport-Sync Started
Dec 12 19:21:45 rivoplus volumio[3725]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done'
Dec 12 19:21:45 rivoplus sudo[11158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 12 19:21:45 rivoplus sudo[11158]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:45 rivoplus volumio[3725]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-t861f0ne/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus sudo[11158]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:45 rivoplus sudo[11160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 12 19:21:45 rivoplus sudo[11160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:45 rivoplus sudo[11153]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 12 19:21:45 rivoplus sudo[11153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 12 19:21:45 rivoplus sudo[11153]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:45 rivoplus qobuz-connect[11133]: 20251212 19:21:45.299 [11133.11133] INFO SampleApp: Stopping Local configuration server
Dec 12 19:21:45 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service...
Dec 12 19:21:45 rivoplus qobuz-connect[11133]: 20251212 19:21:45.310 [11133.11133] INFO SampleApp: shat down connection on UNIX socket
Dec 12 19:21:45 rivoplus systemd[1]: qobuz-connect.service: Succeeded.
Dec 12 19:21:45 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service.
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:45 rivoplus systemd[1]: Started Volumio Qobuz Connect Service.
Dec 12 19:21:45 rivoplus volumio[3725]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Dec 12 19:21:45 rivoplus volumio[3725]: info: QobuzConnect: setDeactiveState invoked
Dec 12 19:21:45 rivoplus sudo[11160]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:45 rivoplus volumio[3725]: info: Successfully built camilladsp-plot
Dec 12 19:21:45 rivoplus volumio[3725]: info: Starting Shairport Sync
Dec 12 19:21:45 rivoplus volumio[3725]: info: Executing endpoint qc_getconfig
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.446 [11170.11170] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.452 [11170.11170] INFO VolumeManager: [0xab4ff8f0]: Setting new playback volume: 75
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.452 [11170.11170] INFO VolumeManager: [0xab4ff8f0]: Setting new mute state: 0
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.452 [11170.11170] INFO QobuzConnect: [0xab5002c0]: Client initialized!
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.453 [11170.11170] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp
Dec 12 19:21:45 rivoplus sudo[11173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 12 19:21:45 rivoplus volumio[3725]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Dec 12 19:21:45 rivoplus volumio[3725]: info: QobuzConnect: QOBUZ Connect daemon connected
Dec 12 19:21:45 rivoplus sudo[11173]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.472 [11170.11170] INFO LocalConfigManager: [0xab4ff1d0]: Starting Local Configuration server
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.472 [11170.11170] INFO SampleApp: Starting Local configuration server
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.473 [11170.11170] INFO SampleApp: Connected to UNIX socket client 0xab4f4ed8
Dec 12 19:21:45 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 12 19:21:45 rivoplus systemd[1]: shairport-sync.service: Succeeded.
Dec 12 19:21:45 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 12 19:21:45 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 12 19:21:45 rivoplus sudo[11173]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:45 rivoplus volumio[3725]: info: Shairport-Sync Started
Dec 12 19:21:45 rivoplus qobuz-connect[11170]: 20251212 19:21:45.595 [11170.11170] INFO SampleApp: Playback volume changed: 75
Dec 12 19:21:45 rivoplus volumio[3725]: info: CoreCommandRouter::volumioGetState
Dec 12 19:21:45 rivoplus volumio[3725]: info: copying hw detection script
Dec 12 19:21:45 rivoplus volumio[3725]: info: Detected cpu architecture as aarch64
Dec 12 19:21:46 rivoplus volumio[3725]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Dec 12 19:21:46 rivoplus volumio[3725]: 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
Dec 12 19:21:46 rivoplus volumio[3725]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Dec 12 19:21:46 rivoplus volumio[3725]: info: camilladsp spawned new process with pid undefined, instance 2, run: true
Dec 12 19:21:46 rivoplus volumio[3725]: info: camilladsp service started and running in background, instance 2
Dec 12 19:21:46 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 12 19:21:46 rivoplus volumio[3725]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Dec 12 19:21:46 rivoplus volumio[3725]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Dec 12 19:21:46 rivoplus volumio[3725]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Dec 12 19:21:46 rivoplus volumio[3725]: info: FusionDsp loaded
Dec 12 19:21:46 rivoplus volumio[3725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:21:46 rivoplus sudo[11195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Dec 12 19:21:46 rivoplus sudo[11195]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:46 rivoplus volumio[3725]: info: FusionDsp - Reporting Fusion DSP Enabled
Dec 12 19:21:46 rivoplus volumio[3725]: info: Adding Signal Path Element [object Object]
Dec 12 19:21:46 rivoplus volumio[3725]: info: Adding fusiondspeq DSP Signal Path Element
Dec 12 19:21:46 rivoplus volumio[3725]: info: FusionDsp - ---- installed callbackRead
Dec 12 19:21:46 rivoplus volumio[3725]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 12 19:21:46 rivoplus systemd[1]: Started FusionDsp Daemon.
Dec 12 19:21:46 rivoplus volumio[3725]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Dec 12 19:21:46 rivoplus volumio[3725]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19)
Dec 12 19:21:46 rivoplus volumio[3725]: at onErrorNT (internal/child_process.js:472:16)
Dec 12 19:21:46 rivoplus volumio[3725]: at processTicksAndRejections (internal/process/task_queues.js:82:21) {
Dec 12 19:21:46 rivoplus volumio[3725]: errno: -2,
Dec 12 19:21:46 rivoplus volumio[3725]: code: 'ENOENT',
Dec 12 19:21:46 rivoplus volumio[3725]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Dec 12 19:21:46 rivoplus volumio[3725]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Dec 12 19:21:46 rivoplus volumio[3725]: spawnargs: [
Dec 12 19:21:46 rivoplus volumio[3725]: '-p',
Dec 12 19:21:46 rivoplus volumio[3725]: 9876,
Dec 12 19:21:46 rivoplus volumio[3725]: '-o',
Dec 12 19:21:46 rivoplus volumio[3725]: '/tmp/camilladsp.log',
Dec 12 19:21:46 rivoplus volumio[3725]: '-l',
Dec 12 19:21:46 rivoplus volumio[3725]: 'warn',
Dec 12 19:21:46 rivoplus volumio[3725]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Dec 12 19:21:46 rivoplus volumio[3725]: ]
Dec 12 19:21:46 rivoplus volumio[3725]: }
Dec 12 19:21:46 rivoplus volumio[3725]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 12 19:21:46 rivoplus sudo[11195]: pam_unix(sudo:session): session closed for user root
Dec 12 19:21:47 rivoplus sudo[11208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-12 19:20
Dec 12 19:21:47 rivoplus sudo[11208]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 12 19:21:47 rivoplus mpd[11169]: Dec 12 19:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 12 19:21:47 rivoplus systemd[1]: Started Music Player Daemon.
Dec 12 19:21:47 rivoplus sudo[11100]: pam_unix(sudo:session): session closed for user root
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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivoplus"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:23:19 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="ca35d8983c8e34dfa9cca80071cf9105"