-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2025-10-25 19:01:38 CEST. --
Oct 25 19:00:02 volumio-uz volumio[990]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ...
Oct 25 19:00:02 volumio-uz volumio[990]: info: Setting up dpkg-dev (1.19.8) ...
Oct 25 19:00:02 volumio-uz volumio[990]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ...
Oct 25 19:00:06 volumio-uz volumio[990]: info: Setting up python3-pip (18.1-5+rpt1) ...
Oct 25 19:00:08 volumio-uz volumio[990]: info: Updating volume from AirPlay: -13.12; 56%
Oct 25 19:00:08 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume56
Oct 25 19:00:08 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:08 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:08 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 50
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 56
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:08 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 56
Oct 25 19:00:08 volumio-uz volumio[990]: info: Updating volume from AirPlay: -11.25; 63%
Oct 25 19:00:08 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume63
Oct 25 19:00:08 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:08 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:08 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 63
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 56
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 63
Oct 25 19:00:08 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:08 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 63
Oct 25 19:00:08 volumio-uz volumio[990]: info: Updating volume from AirPlay: -9.38; 69%
Oct 25 19:00:08 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume69
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 63
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 69
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:09 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 69
Oct 25 19:00:09 volumio-uz volumio[990]: info: Updating volume from AirPlay: -7.5; 75%
Oct 25 19:00:09 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume75
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 69
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 75
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:09 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 75
Oct 25 19:00:09 volumio-uz volumio[990]: info: Updating volume from AirPlay: -3.75; 88%
Oct 25 19:00:09 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume88
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 75
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 88
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:09 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 88
Oct 25 19:00:09 volumio-uz volumio[990]: info: Updating volume from AirPlay: -1.88; 94%
Oct 25 19:00:09 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume94
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:09 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 88
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 94
Oct 25 19:00:09 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:09 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 94
Oct 25 19:00:10 volumio-uz volumio[990]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ...
Oct 25 19:00:10 volumio-uz volumio[990]: info: Setting up cpp (4:8.3.0-1+rpi2) ...
Oct 25 19:00:10 volumio-uz volumio[990]: info: Setting up python3-keyrings.alt (3.1.1-1) ...
Oct 25 19:00:11 volumio-uz volumio[990]: SPOTIFY: SETTING SPOTIFY VOLUME 94
Oct 25 19:00:11 volumio-uz volumio[990]: info: Sending Spotify command with payload to local API: /player/volume
Oct 25 19:00:11 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:11+02:00" level=debug msg="update volume requested to 61602/65535"
Oct 25 19:00:11 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:11+02:00" level=debug msg="put connect state because VOLUME_CHANGED"
Oct 25 19:00:11 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:11+02:00" level=trace msg="emitting websocket event: volume"
Oct 25 19:00:11 volumio-uz volumio[990]: SPOTIFY: received: {"type":"volume","data":{"value":94,"max":100}}
Oct 25 19:00:11 volumio-uz volumio[990]: SPOTIFY: RECEIVED SPOTIFY VOLUME 94
Oct 25 19:00:11 volumio-uz volumio[990]: SPOTIFY: received: {"type":"volume","data":{"value":94,"max":100}}
Oct 25 19:00:11 volumio-uz volumio[990]: SPOTIFY: RECEIVED SPOTIFY VOLUME 94
Oct 25 19:00:12 volumio-uz volumio[990]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ...
Oct 25 19:00:12 volumio-uz volumio[990]: info: Setting up gcc-8 (8.3.0-6+rpi1) ...
Oct 25 19:00:12 volumio-uz volumio[990]: info: Setting up libpython3-dev:armhf (3.7.3-1) ...
Oct 25 19:00:13 volumio-uz volumio[990]: info: Setting up gcc (4:8.3.0-1+rpi2) ...
Oct 25 19:00:13 volumio-uz volumio[990]: info: Setting up python3-secretstorage (2.3.1-2) ...
Oct 25 19:00:15 volumio-uz volumio[990]: info: Setting up python3-dev (3.7.3-1) ...
Oct 25 19:00:15 volumio-uz volumio[990]: info: Setting up g++-8 (8.3.0-6+rpi1) ...
Oct 25 19:00:15 volumio-uz volumio[990]: info: Setting up python3-keyring (17.1.1-1) ...
Oct 25 19:00:15 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:15+02:00" level=trace msg="sent dealer ping"
Oct 25 19:00:15 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:15+02:00" level=trace msg="received dealer pong"
Oct 25 19:00:18 volumio-uz volumio[990]: info: Setting up g++ (4:8.3.0-1+rpi2) ...
Oct 25 19:00:18 volumio-uz volumio[990]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode
Oct 25 19:00:18 volumio-uz volumio[990]: info: Setting up build-essential (12.6) ...
Oct 25 19:00:18 volumio-uz volumio[990]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ...
Oct 25 19:00:27 volumio-uz sudo[7644]: pam_unix(sudo:session): session closed for user root
Oct 25 19:00:27 volumio-uz sudo[8876]:     root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C /
Oct 25 19:00:27 volumio-uz sudo[8876]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:00:27 volumio-uz volumio[990]: info: lib/systemd/system/fusiondsp.service
Oct 25 19:00:27 volumio-uz sudo[8876]: pam_unix(sudo:session): session closed for user root
Oct 25 19:00:34 volumio-uz volumio[990]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant
Oct 25 19:00:34 volumio-uz volumio[990]: info: more info at http://www.winimage.com/zLibDll/unzip.html
Oct 25 19:00:34 volumio-uz volumio[990]: info:
Oct 25 19:00:34 volumio-uz volumio[990]: info: cgui-1.0.0.zip opened
Oct 25 19:00:34 volumio-uz volumio[990]: info: creating directory: cgui/
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/LICENSE.txt
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/README.md
Oct 25 19:00:34 volumio-uz volumio[990]: info: creating directory: cgui/build/
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/robots.txt
Oct 25 19:00:34 volumio-uz sudo[8894]:     root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui
Oct 25 19:00:34 volumio-uz sudo[8894]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/logo512.png
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/asset-manifest.json
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/index.html
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/.put_statics_here
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/favicon.ico
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/logo192.png
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/manifest.json
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/css-variables.css
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/service-worker.js
Oct 25 19:00:34 volumio-uz volumio[990]: info:  extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/build/static/
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/build/static/css/
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/main.d51d005e.chunk.css
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/main.d51d005e.chunk.css.map
Oct 25 19:00:35 volumio-uz sudo[8894]: pam_unix(sudo:session): session closed for user root
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/2.975d6916.chunk.css.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/main.56bdf14e.chunk.css
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/main.1503f6cd.css.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/main.1503f6cd.css
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/2.975d6916.chunk.css
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/build/static/media/
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/media/camilladsp.95719842.svg
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/build/static/js/
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.71e11955.js
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/runtime-main.422581ec.js
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/2.fd49ece5.chunk.js
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt
Oct 25 19:00:35 volumio-uz sudo[8896]:     root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui
Oct 25 19:00:35 volumio-uz sudo[8896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.61bb6809.chunk.js
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.61bb6809.chunk.js.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/2.c1b9df8b.chunk.js
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.71e11955.js.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/runtime-main.422581ec.js.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/main.1b3ac690.chunk.js
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/config/
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/config/camillagui.yml
Oct 25 19:00:35 volumio-uz sudo[8896]: pam_unix(sudo:session): session closed for user root
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/config/gui-config.yml
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/backend/
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/filters_test.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/version.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/filters.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/settings.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/views.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/filterdefaults.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__init__.py
Oct 25 19:00:35 volumio-uz volumio[990]: info: creating directory: cgui/backend/__pycache__/
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/views.cpython-37.pyc
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/settings.cpython-37.pyc
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/routes.cpython-37.pyc
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc
Oct 25 19:00:35 volumio-uz sudo[8898]:     root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/filters.cpython-37.pyc
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/__pycache__/version.cpython-37.pyc
Oct 25 19:00:35 volumio-uz sudo[8898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/routes.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/backend/filemanagement.py
Oct 25 19:00:35 volumio-uz volumio[990]: info:  extracting: cgui/main.py
Oct 25 19:00:35 volumio-uz sudo[8898]: pam_unix(sudo:session): session closed for user root
Oct 25 19:00:36 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:36+02:00" level=debug msg="skipping dealer message" uri=playback-settings/content-settings-update
Oct 25 19:00:36 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:36+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 162"
Oct 25 19:00:45 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:45+02:00" level=trace msg="received accesspoint ping"
Oct 25 19:00:45 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:45+02:00" level=trace msg="received accesspoint pong ack"
Oct 25 19:00:45 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:45+02:00" level=trace msg="sent dealer ping"
Oct 25 19:00:45 volumio-uz go-librespot[6151]: time="2025-10-25T19:00:45+02:00" level=trace msg="received dealer pong"
Oct 25 19:00:56 volumio-uz volumio[990]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
Oct 25 19:00:56 volumio-uz volumio[990]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0
Oct 25 19:00:56 volumio-uz volumio[990]: info:   Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-qsws9xkb
Oct 25 19:00:57 volumio-uz volumio[990]: info: Updating volume from AirPlay: -3.75; 88%
Oct 25 19:00:57 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume88
Oct 25 19:00:57 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:57 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:57 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:57 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88
Oct 25 19:00:57 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 94
Oct 25 19:00:57 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 88
Oct 25 19:00:57 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:57 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 88
Oct 25 19:00:58 volumio-uz volumio[990]: info: Updating volume from AirPlay: -5.62; 81%
Oct 25 19:00:58 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume81
Oct 25 19:00:58 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:58 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:58 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:58 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81
Oct 25 19:00:58 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 88
Oct 25 19:00:58 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 81
Oct 25 19:00:58 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:58 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 81
Oct 25 19:00:59 volumio-uz volumio[990]: info: Updating volume from AirPlay: -7.5; 75%
Oct 25 19:00:59 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume75
Oct 25 19:00:59 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:00:59 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:00:59 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:00:59 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:00:59 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 81
Oct 25 19:00:59 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 75
Oct 25 19:00:59 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:00:59 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 75
Oct 25 19:01:00 volumio-uz volumio[990]: SPOTIFY: SETTING SPOTIFY VOLUME 75
Oct 25 19:01:00 volumio-uz volumio[990]: info: Sending Spotify command with payload to local API: /player/volume
Oct 25 19:01:00 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:00+02:00" level=debug msg="update volume requested to 49151/65535"
Oct 25 19:01:01 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:01+02:00" level=debug msg="put connect state because VOLUME_CHANGED"
Oct 25 19:01:01 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:01+02:00" level=trace msg="emitting websocket event: volume"
Oct 25 19:01:01 volumio-uz volumio[990]: SPOTIFY: received: {"type":"volume","data":{"value":75,"max":100}}
Oct 25 19:01:01 volumio-uz volumio[990]: SPOTIFY: RECEIVED SPOTIFY VOLUME 75
Oct 25 19:01:01 volumio-uz volumio[990]: SPOTIFY: received: {"type":"volume","data":{"value":75,"max":100}}
Oct 25 19:01:01 volumio-uz volumio[990]: SPOTIFY: RECEIVED SPOTIFY VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:02 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:02 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:03 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:03 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75
Oct 25 19:01:05 volumio-uz volumio[990]: info: Collecting PyYAML (from camilladsp==1.0.0)
Oct 25 19:01:06 volumio-uz volumio[990]: info: Updating volume from AirPlay: -5.62; 81%
Oct 25 19:01:06 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume81
Oct 25 19:01:06 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:06 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:06 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:06 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81
Oct 25 19:01:06 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 75
Oct 25 19:01:06 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 81
Oct 25 19:01:06 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:01:06 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 81
Oct 25 19:01:07 volumio-uz volumio[990]: info: Updating volume from AirPlay: -3.75; 88%
Oct 25 19:01:07 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume88
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 81
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 88
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:01:07 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 88
Oct 25 19:01:07 volumio-uz volumio[990]: info: Updating volume from AirPlay: -1.88; 94%
Oct 25 19:01:07 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume94
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 88
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 94
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:01:07 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 94
Oct 25 19:01:07 volumio-uz volumio[990]: info: Updating volume from AirPlay: 0; 100%
Oct 25 19:01:07 volumio-uz volumio[990]: info: VolumeController::SetAlsaVolume100
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:07 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: SPOTIFY VOLUME 94
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: VOLUMIO VOLUME 100
Oct 25 19:01:07 volumio-uz volumio[990]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 25 19:01:07 volumio-uz volumio[990]: info: Setting Spotify Volume from Volumio: 100
Oct 25 19:01:09 volumio-uz volumio[990]: SPOTIFY: SETTING SPOTIFY VOLUME 100
Oct 25 19:01:09 volumio-uz volumio[990]: info: Sending Spotify command with payload to local API: /player/volume
Oct 25 19:01:09 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:09+02:00" level=debug msg="update volume requested to 65535/65535"
Oct 25 19:01:09 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:09+02:00" level=debug msg="put connect state because VOLUME_CHANGED"
Oct 25 19:01:09 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:09+02:00" level=trace msg="emitting websocket event: volume"
Oct 25 19:01:09 volumio-uz volumio[990]: SPOTIFY: received: {"type":"volume","data":{"value":100,"max":100}}
Oct 25 19:01:09 volumio-uz volumio[990]: SPOTIFY: RECEIVED SPOTIFY VOLUME 100
Oct 25 19:01:09 volumio-uz volumio[990]: SPOTIFY: received: {"type":"volume","data":{"value":100,"max":100}}
Oct 25 19:01:09 volumio-uz volumio[990]: SPOTIFY: RECEIVED SPOTIFY VOLUME 100
Oct 25 19:01:11 volumio-uz volumio[990]: info:   Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB)
Oct 25 19:01:12 volumio-uz volumio[990]: info: Collecting websocket_client (from camilladsp==1.0.0)
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: info:   Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB)
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::servicePushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:14 volumio-uz shairport-sync[3448]: {"time":1761411235405,"response":"startAirplayPlayback Success"}  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
Oct 25 19:01:14 volumio-uz shairport-sync[3448]:                                  Dload  Upload   Total   Spent    Left  Speed
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 19:01:14 volumio-uz volumio[990]: info: Discovery: Getting this device information
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 19:01:14 volumio-uz volumio[990]: info: Discovery: Getting this device information
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:14 volumio-uz volumio[990]: info:
Oct 25 19:01:14 volumio-uz volumio[990]: ---------------------------- Client requests Stop Airplay Playback
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
Oct 25 19:01:14 volumio-uz volumio[990]: info: Airplay playback stop
Oct 25 19:01:14 volumio-uz volumio[990]: info: Airplay Playback Stopped, clearing state
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::resetVolumioState
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreStateMachine::getcurrentVolume
Oct 25 19:01:14 volumio-uz volumio[990]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 19:01:14 volumio-uz shairport-sync[3448]: [237B blob data]
Oct 25 19:01:15 volumio-uz volumio[990]: info: Building wheels for collected packages: camilladsp
Oct 25 19:01:15 volumio-uz volumio[990]: info:   Running setup.py bdist_wheel for camilladsp: started
Oct 25 19:01:15 volumio-uz volumio[990]: info: VolumeController:: Volume=100 Mute =false
Oct 25 19:01:15 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:15 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:15 volumio-uz volumio[990]: info: CoreStateMachine::updateTrackBlock
Oct 25 19:01:15 volumio-uz volumio[990]: info: CorePlayQueue::getTrackBlock
Oct 25 19:01:15 volumio-uz volumio[990]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 19:01:15 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:15 volumio-uz volumio[990]: verbose: New Socket.io Connection to 192.168.178.195:3000 from 192.168.178.98 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5
Oct 25 19:01:15 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:15+02:00" level=trace msg="sent dealer ping"
Oct 25 19:01:15 volumio-uz go-librespot[6151]: time="2025-10-25T19:01:15+02:00" level=trace msg="received dealer pong"
Oct 25 19:01:15 volumio-uz volumio[990]: info: VolumeController:: Volume=100 Mute =false
Oct 25 19:01:15 volumio-uz volumio[990]: info: CoreStateMachine::pushState
Oct 25 19:01:15 volumio-uz volumio[990]: info: CoreCommandRouter::volumioPushState
Oct 25 19:01:15 volumio-uz volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Oct 25 19:01:17 volumio-uz volumio[990]: verbose: New Socket.io Connection to 192.168.178.195 from 192.168.178.98 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6
Oct 25 19:01:17 volumio-uz volumio[990]: info: Received Get System Info
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 19:01:17 volumio-uz volumio[990]: info: Discovery: Getting this device information
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 25 19:01:17 volumio-uz volumio[990]: info: Received Get System Info
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 19:01:17 volumio-uz volumio[990]: info: Discovery: Getting this device information
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetState
Oct 25 19:01:17 volumio-uz volumio[990]: info: Listing playlists
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::volumioGetQueue
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreStateMachine::getQueue
Oct 25 19:01:17 volumio-uz volumio[990]: info: CorePlayQueue::getQueue
Oct 25 19:01:17 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 25 19:01:20 volumio-uz volumio[990]: info:   Running setup.py bdist_wheel for camilladsp: finished with status 'done'
Oct 25 19:01:20 volumio-uz volumio[990]: info:   Stored in directory: /tmp/pip-ephem-wheel-cache-2idsbu03/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6
Oct 25 19:01:20 volumio-uz volumio[990]: info: Successfully built camilladsp
Oct 25 19:01:21 volumio-uz volumio[990]: info: Installing collected packages: PyYAML, websocket-client, camilladsp
Oct 25 19:01:23 volumio-uz volumio[990]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1
Oct 25 19:01:26 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 25 19:01:26 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 25 19:01:30 volumio-uz volumio[990]: info: Enabling plugin fusiondsp
Oct 25 19:01:30 volumio-uz volumio[990]: info: Loading plugin "fusiondsp"...
Oct 25 19:01:31 volumio-uz volumio[990]: info: Preparing to generate the ALSA configuration file
Oct 25 19:01:32 volumio-uz volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 19:01:32 volumio-uz volumio[990]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 19:01:32 volumio-uz volumio[990]: info: Output device has changed, restarting MPD
Oct 25 19:01:32 volumio-uz volumio[990]: info: Output device has changed, restarting Shairport Sync
Oct 25 19:01:32 volumio-uz sudo[9074]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 19:01:32 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:32 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 19:01:32 volumio-uz sudo[9074]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:01:32 volumio-uz sudo[9074]: pam_unix(sudo:session): session closed for user root
Oct 25 19:01:32 volumio-uz sudo[9076]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 19:01:32 volumio-uz sudo[9076]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:01:32 volumio-uz systemd[1]: Stopping Music Player Daemon...
Oct 25 19:01:32 volumio-uz volumio[990]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 19:01:32 volumio-uz volumio[990]: info: PLUGIN START: fusiondsp
Oct 25 19:01:32 volumio-uz volumio[990]: info: Loading i18n strings for locale de
Oct 25 19:01:32 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Oct 25 19:01:32 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:32 volumio-uz volumio[990]: info: FusionDsp -  mixtype--------------------- Hardware
Oct 25 19:01:32 volumio-uz volumio[990]: info: Preparing to generate the ALSA configuration file
Oct 25 19:01:32 volumio-uz volumio[990]: info: Done.
Oct 25 19:01:32 volumio-uz volumio[990]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Oct 25 19:01:32 volumio-uz volumio[990]: info: Reading ALSA contributions from plugins.
Oct 25 19:01:32 volumio-uz volumio[990]: info: MPD Permissions set
Oct 25 19:01:32 volumio-uz volumio[990]: info: FusionDsp -
Oct 25 19:01:33 volumio-uz volumio[990]: info: FusionDsp - undefined
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:33 volumio-uz volumio[990]: info: FusionDsp -
Oct 25 19:01:34 volumio-uz volumio[990]: info: FusionDsp -
Oct 25 19:01:35 volumio-uz volumio[990]: info: camilladsp service started and running in background, instance 1
Oct 25 19:01:35 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 19:01:35 volumio-uz volumio[990]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Oct 25 19:01:35 volumio-uz volumio[990]: error: FusionDsp -  ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Oct 25 19:01:35 volumio-uz volumio[990]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Oct 25 19:01:35 volumio-uz volumio[990]: info: FusionDsp loaded
Oct 25 19:01:35 volumio-uz volumio[990]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 19:01:35 volumio-uz sudo[9110]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Oct 25 19:01:35 volumio-uz sudo[9110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:01:35 volumio-uz volumio[990]: info: FusionDsp -  Reporting Fusion DSP Enabled
Oct 25 19:01:35 volumio-uz volumio[990]: info: Adding Signal Path Element [object Object]
Oct 25 19:01:35 volumio-uz volumio[990]: info: Adding fusiondspeq DSP Signal Path Element
Oct 25 19:01:35 volumio-uz volumio[990]: info: FusionDsp -  ---- installed callbackRead
Oct 25 19:01:35 volumio-uz volumio[990]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 19:01:35 volumio-uz volumio[990]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Oct 25 19:01:35 volumio-uz volumio[990]:     at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Oct 25 19:01:35 volumio-uz volumio[990]:     at onErrorNT (internal/child_process.js:465:16)
Oct 25 19:01:35 volumio-uz volumio[990]:     at processTicksAndRejections (internal/process/task_queues.js:80:21)
Oct 25 19:01:35 volumio-uz volumio[990]:     at runNextTicks (internal/process/task_queues.js:62:3)
Oct 25 19:01:35 volumio-uz volumio[990]:     at listOnTimeout (internal/timers.js:523:9)
Oct 25 19:01:35 volumio-uz volumio[990]:     at processTimers (internal/timers.js:497:7) {
Oct 25 19:01:35 volumio-uz volumio[990]:   errno: -2,
Oct 25 19:01:35 volumio-uz volumio[990]:   code: 'ENOENT',
Oct 25 19:01:35 volumio-uz volumio[990]:   syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Oct 25 19:01:35 volumio-uz volumio[990]:   path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Oct 25 19:01:35 volumio-uz volumio[990]:   spawnargs: [
Oct 25 19:01:35 volumio-uz volumio[990]:     '-p',
Oct 25 19:01:35 volumio-uz volumio[990]:     9876,
Oct 25 19:01:35 volumio-uz volumio[990]:     '-o',
Oct 25 19:01:35 volumio-uz volumio[990]:     '/tmp/camilladsp.log',
Oct 25 19:01:35 volumio-uz volumio[990]:     '-l',
Oct 25 19:01:35 volumio-uz volumio[990]:     'warn',
Oct 25 19:01:35 volumio-uz volumio[990]:     '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Oct 25 19:01:35 volumio-uz volumio[990]:   ]
Oct 25 19:01:35 volumio-uz volumio[990]: }
Oct 25 19:01:35 volumio-uz volumio[990]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 19:01:35 volumio-uz systemd[1]: Started FusionDsp Daemon.
Oct 25 19:01:36 volumio-uz sudo[9110]: pam_unix(sudo:session): session closed for user root
Oct 25 19:01:36 volumio-uz systemd[1]: mpd.service: Succeeded.
Oct 25 19:01:36 volumio-uz systemd[1]: Stopped Music Player Daemon.
Oct 25 19:01:36 volumio-uz systemd[1]: Starting Music Player Daemon...
Oct 25 19:01:37 volumio-uz sudo[9121]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 25 19:01:37 volumio-uz sudo[9121]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 19:01:37 volumio-uz sudo[9121]: pam_unix(sudo:session): session closed for user root
Oct 25 19:01:38 volumio-uz sudo[9127]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-25 19:00
Oct 25 19:01:38 volumio-uz sudo[9127]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"