-- Logs begin at Thu 2019-02-14 21:11:58 AEDT, end at Sat 2025-12-13 17:45:31 AEDT. --
Dec 13 17:44:01 princess-leia volumiologrotate[569]: ls: cannot access '/var/log/samba/log.wb-PRINCESS': No such file or directory
Dec 13 17:44:01 princess-leia volumiologrotate[569]: ls: cannot access 'LEIA': No such file or directory
Dec 13 17:44:30 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 13 17:44:30 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 13 17:44:39 princess-leia volumio[828]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 13 17:44:41 princess-leia volumio[828]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 13 17:44:41 princess-leia volumio[828]: info: FusionDsp - Stopping FusionDsp service
Dec 13 17:44:41 princess-leia volumio[828]: info: camilladsp stopping service pid 630...
Dec 13 17:44:41 princess-leia volumio[828]: info: camilladsp service terminated, instance 1
Dec 13 17:44:41 princess-leia sudo[4941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service
Dec 13 17:44:41 princess-leia sudo[4941]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:41 princess-leia systemd[1]: Stopping FusionDsp Daemon...
Dec 13 17:44:41 princess-leia volumio[1148]: Backend configuration:
Dec 13 17:44:41 princess-leia volumio[1148]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Dec 13 17:44:41 princess-leia volumio[1148]: active_config_txt: null
Dec 13 17:44:41 princess-leia volumio[1148]: camilla_host: 127.0.0.1
Dec 13 17:44:41 princess-leia volumio[1148]: camilla_port: 9876
Dec 13 17:44:41 princess-leia volumio[1148]: coeff_dir: /data/INTERNAL/FusionDsp/filters
Dec 13 17:44:41 princess-leia volumio[1148]: config_dir: /data/configuration/audio_interface/fusiondsp
Dec 13 17:44:41 princess-leia volumio[1148]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml
Dec 13 17:44:41 princess-leia volumio[1148]: log_file: /tmp/camilladsp.log
Dec 13 17:44:41 princess-leia volumio[1148]: on_get_active_config: null
Dec 13 17:44:41 princess-leia volumio[1148]: on_set_active_config: null
Dec 13 17:44:41 princess-leia volumio[1148]: port: 5011
Dec 13 17:44:41 princess-leia volumio[1148]: supported_capture_types: null
Dec 13 17:44:41 princess-leia volumio[1148]: supported_playback_types: null
Dec 13 17:44:41 princess-leia volumio[1148]: update_config_symlink: false
Dec 13 17:44:41 princess-leia volumio[1148]: update_config_txt: false
Dec 13 17:44:41 princess-leia volumio[1148]: ======== Running on http://0.0.0.0:5011 ========
Dec 13 17:44:41 princess-leia volumio[1148]: (Press CTRL+C to quit)
Dec 13 17:44:41 princess-leia systemd[1]: fusiondsp.service: Succeeded.
Dec 13 17:44:41 princess-leia systemd[1]: Stopped FusionDsp Daemon.
Dec 13 17:44:41 princess-leia sudo[4941]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:41 princess-leia volumio[828]: info: FusionDsp - Reporting Fusion DSP Disabled
Dec 13 17:44:41 princess-leia volumio[828]: info: Removing fusiondspeq DSP Signal Path Element
Dec 13 17:44:42 princess-leia volumio[828]: info: Check plugin dependencies
Dec 13 17:44:42 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 13 17:44:42 princess-leia volumio[828]: info: Rename folder
Dec 13 17:44:42 princess-leia volumio[828]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 13 17:44:42 princess-leia volumio[828]: info: Move to category
Dec 13 17:44:43 princess-leia volumio[828]: info: Checking if install.sh is present
Dec 13 17:44:43 princess-leia volumio[828]: info: Executing install.sh
Dec 13 17:44:43 princess-leia sudo[4961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh
Dec 13 17:44:43 princess-leia sudo[4961]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:43 princess-leia volumio[828]: info: creating filters folder and copying demo filters
Dec 13 17:44:43 princess-leia volumio[828]: info: copying demo flters
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/2XEQ15/
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/2XEQ15/.Bass-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/2XEQ15/.Classic-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/2XEQ15/.Voice-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/2XEQ15/.Rock-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/PEQ/
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/convfir/
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/convfir/kef.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/convfir/test.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/EQ15/
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/EQ15/.Bass-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/EQ15/.Classic-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/EQ15/.Voice-FusionDsp.json
Dec 13 17:44:43 princess-leia volumio[828]: info: ./presets/EQ15/.Rock-FusionDsp.json
Dec 13 17:44:43 princess-leia sudo[4988]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update
Dec 13 17:44:43 princess-leia sudo[4988]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:43 princess-leia volumio[828]: info: Installing/fusiondsp dependencies
Dec 13 17:44:43 princess-leia volumio[828]: info: Get:1 https://deb.nodesource.com/node_14.x buster InRelease [4584 B]
Dec 13 17:44:44 princess-leia volumio[828]: info: Get:2 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB]
Dec 13 17:44:44 princess-leia volumio[828]: info: Ign:3 http://raspbian.raspberrypi.org/raspbian buster InRelease
Dec 13 17:44:44 princess-leia volumio[828]: info: Err:4 http://raspbian.raspberrypi.org/raspbian buster Release
Dec 13 17:44:44 princess-leia volumio[828]: info: 404 Not Found [IP: 93.93.128.193 80]
Dec 13 17:44:45 princess-leia volumio[828]: info: Get:5 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB]
Dec 13 17:44:49 princess-leia volumio[828]: info: Reading package lists...
Dec 13 17:44:49 princess-leia sudo[4988]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:49 princess-leia sudo[5154]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip
Dec 13 17:44:49 princess-leia sudo[5154]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:50 princess-leia volumio[828]: info: Reading package lists...
Dec 13 17:44:51 princess-leia volumio[828]: info: Building dependency tree...
Dec 13 17:44:51 princess-leia volumio[828]: info: Reading state information...
Dec 13 17:44:52 princess-leia volumio[828]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1).
Dec 13 17:44:52 princess-leia sudo[5154]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:52 princess-leia volumio[828]: info: python3-pip is already the newest version (18.1-5+rpt1).
Dec 13 17:44:52 princess-leia volumio[828]: info: 0 upgraded, 0 newly installed, 0 to remove and 132 not upgraded.
Dec 13 17:44:52 princess-leia sudo[5166]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C /
Dec 13 17:44:52 princess-leia sudo[5166]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:52 princess-leia volumio[828]: info: lib/systemd/system/fusiondsp.service
Dec 13 17:44:52 princess-leia sudo[5166]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:54 princess-leia volumio[828]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant
Dec 13 17:44:54 princess-leia volumio[828]: info: more info at http://www.winimage.com/zLibDll/unzip.html
Dec 13 17:44:54 princess-leia volumio[828]: info:
Dec 13 17:44:54 princess-leia volumio[828]: info: cgui-1.0.0.zip opened
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/LICENSE.txt
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/README.md
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/build/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/robots.txt
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/logo512.png
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/asset-manifest.json
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/index.html
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/.put_statics_here
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/favicon.ico
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/logo192.png
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/manifest.json
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/css-variables.css
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/service-worker.js
Dec 13 17:44:54 princess-leia sudo[5176]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui
Dec 13 17:44:54 princess-leia sudo[5176]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/build/static/
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/build/static/css/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/main.1503f6cd.css
Dec 13 17:44:54 princess-leia sudo[5176]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/build/static/media/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/build/static/js/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.71e11955.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.71e11955.js.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/config/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/config/camillagui.yml
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/config/gui-config.yml
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/backend/
Dec 13 17:44:54 princess-leia sudo[5178]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/filters_test.py
Dec 13 17:44:54 princess-leia sudo[5178]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/version.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/filters.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/settings.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/views.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/filterdefaults.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__init__.py
Dec 13 17:44:54 princess-leia volumio[828]: info: creating directory: cgui/backend/__pycache__/
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc
Dec 13 17:44:54 princess-leia sudo[5178]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/routes.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/backend/filemanagement.py
Dec 13 17:44:54 princess-leia volumio[828]: info: extracting: cgui/main.py
Dec 13 17:44:54 princess-leia sudo[5180]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip
Dec 13 17:44:54 princess-leia sudo[5180]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:44:54 princess-leia sudo[5180]: pam_unix(sudo:session): session closed for user root
Dec 13 17:44:58 princess-leia volumio[828]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
Dec 13 17:44:58 princess-leia volumio[828]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0
Dec 13 17:44:58 princess-leia volumio[828]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-20p4oxe2
Dec 13 17:45:00 princess-leia volumio[828]: 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 13 17:45:00 princess-leia volumio[828]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0)
Dec 13 17:45:00 princess-leia volumio[828]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.5.2)
Dec 13 17:45:00 princess-leia volumio[828]: info: Building wheels for collected packages: camilladsp
Dec 13 17:45:00 princess-leia volumio[828]: info: Running setup.py bdist_wheel for camilladsp: started
Dec 13 17:45:01 princess-leia volumio[828]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done'
Dec 13 17:45:01 princess-leia volumio[828]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-mk0jvwtb/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6
Dec 13 17:45:01 princess-leia volumio[828]: info: Successfully built camilladsp
Dec 13 17:45:01 princess-leia volumiologrotate[569]: ls: cannot access '/var/log/samba/log.wb-PRINCESS': No such file or directory
Dec 13 17:45:01 princess-leia volumiologrotate[569]: ls: cannot access 'LEIA': No such file or directory
Dec 13 17:45:05 princess-leia volumio[828]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
Dec 13 17:45:05 princess-leia volumio[828]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2
Dec 13 17:45:05 princess-leia volumio[828]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-kgtsdsaf
Dec 13 17:45:06 princess-leia volumio[828]: 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 13 17:45:06 princess-leia volumio[828]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0)
Dec 13 17:45:06 princess-leia volumio[828]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3)
Dec 13 17:45:07 princess-leia volumio[828]: 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 13 17:45:07 princess-leia volumio[828]: 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.6.0)
Dec 13 17:45:07 princess-leia volumio[828]: 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 13 17:45:07 princess-leia volumio[828]: 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 13 17:45:07 princess-leia volumio[828]: 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 13 17:45:07 princess-leia volumio[828]: 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.6.3)
Dec 13 17:45:07 princess-leia volumio[828]: 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 13 17:45:07 princess-leia volumio[828]: info: Building wheels for collected packages: camilladsp-plot
Dec 13 17:45:07 princess-leia volumio[828]: info: Running setup.py bdist_wheel for camilladsp-plot: started
Dec 13 17:45:08 princess-leia volumio[828]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done'
Dec 13 17:45:08 princess-leia volumio[828]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-vqxlte5k/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9
Dec 13 17:45:08 princess-leia volumio[828]: info: Successfully built camilladsp-plot
Dec 13 17:45:08 princess-leia volumio[828]: info: copying hw detection script
Dec 13 17:45:08 princess-leia volumio[828]: info: Detected cpu architecture as armv7l
Dec 13 17:45:10 princess-leia sudo[5345]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params
Dec 13 17:45:10 princess-leia sudo[5345]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:45:10 princess-leia sudo[5345]: pam_unix(sudo:session): session closed for user root
Dec 13 17:45:10 princess-leia sudo[5347]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params
Dec 13 17:45:10 princess-leia sudo[5347]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:45:10 princess-leia sudo[5347]: pam_unix(sudo:session): session closed for user root
Dec 13 17:45:10 princess-leia sudo[5349]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc
Dec 13 17:45:10 princess-leia sudo[5349]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 13 17:45:10 princess-leia volumio[828]: info: Reading package lists...
Dec 13 17:45:10 princess-leia volumio[828]: info: Building dependency tree...
Dec 13 17:45:10 princess-leia volumio[828]: info: Reading state information...
Dec 13 17:45:11 princess-leia sudo[5349]: pam_unix(sudo:session): session closed for user root
Dec 13 17:45:11 princess-leia volumio[828]: info: drc is already the newest version (3.2.2~dfsg0-2).
Dec 13 17:45:11 princess-leia sudo[4961]: pam_unix(sudo:session): session closed for user root
Dec 13 17:45:11 princess-leia volumio[828]: info: 0 upgraded, 0 newly installed, 0 to remove and 132 not upgraded.
Dec 13 17:45:11 princess-leia volumio[828]: info: Install script completed
Dec 13 17:45:11 princess-leia volumio[828]: info: Done installing plugin.
Dec 13 17:45:11 princess-leia volumio[828]: info: Enabling plugin fusiondsp
Dec 13 17:45:11 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 13 17:45:11 princess-leia volumio[828]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.62","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.1.1","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Podcast","name":"podcast","category":"music_service","version":"2.2.0","icon":"fa-podcast","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.5","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.5.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}]
Dec 13 17:45:11 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 13 17:45:11 princess-leia volumio[828]: info: Folder /tmp/plugins removed
Dec 13 17:45:11 princess-leia volumio[828]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 13 17:45:11 princess-leia volumio[828]: Plugin install end detected on script
Dec 13 17:45:11 princess-leia volumio[828]: info: Folder /data/temp removed
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::volumioPause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::servicePause
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::servicePause
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::pause
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand pause
Dec 13 17:45:18 princess-leia volumio[828]: info:
Dec 13 17:45:18 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand pause took 2 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:18 princess-leia volumio[828]: info:
Dec 13 17:45:18 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:18 princess-leia volumio[828]: info:
Dec 13 17:45:18 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:18 princess-leia volumio[828]: info:
Dec 13 17:45:18 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand status took 3 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand status took 2 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand status took 1 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand status took 1 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:18 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":71337,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:18 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":71337,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:18 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":71337,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:18 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:18 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":71337,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:18 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:18 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:18 princess-leia volumio[828]: info: ------------------------------ 17ms
Dec 13 17:45:18 princess-leia volumio[828]: info: ------------------------------ 16ms
Dec 13 17:45:18 princess-leia volumio[828]: info: ------------------------------ 16ms
Dec 13 17:45:18 princess-leia volumio[828]: info: ------------------------------ 15ms
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPlay
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::play index undefined
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::startPlaybackTimer
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::resume
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand play
Dec 13 17:45:20 princess-leia volumio[828]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Dec 13 17:45:20 princess-leia volumio[828]: info: FusionDsp - ---- read samplerate from file: 44100
Dec 13 17:45:20 princess-leia volumio[828]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 13 17:45:20 princess-leia volumio[828]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Dec 13 17:45:20 princess-leia volumio[828]: info: FusionDsp - ---- read samplerate from file: 44100
Dec 13 17:45:20 princess-leia volumio[828]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 13 17:45:20 princess-leia volumio[828]: info:
Dec 13 17:45:20 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand play took 29 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:20 princess-leia volumio[828]: info:
Dec 13 17:45:20 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:20 princess-leia volumio[828]: info:
Dec 13 17:45:20 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:20 princess-leia volumio[828]: info:
Dec 13 17:45:20 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand status took 4 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand status took 3 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand status took 2 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand status took 1 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:20 princess-leia volumio[828]: error: FusionDsp - WebSocket error: [object Object]
Dec 13 17:45:20 princess-leia volumio[828]: error: FusionDsp - WebSocket error: [object Object]
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:20 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":72331,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:20 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":72331,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:20 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:20 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":72331,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:20 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:20 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":72331,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:20 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:20 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:20 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:20 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:20 princess-leia volumio[828]: info: ------------------------------ 24ms
Dec 13 17:45:20 princess-leia volumio[828]: info: ------------------------------ 23ms
Dec 13 17:45:20 princess-leia volumio[828]: info: ------------------------------ 23ms
Dec 13 17:45:20 princess-leia volumio[828]: info: ------------------------------ 23ms
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioSeek
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::seek
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: TRACKBLOCK {"uri":"mnt/NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","service":"mpd","name":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=461&web=Tomas%20Dvorak/Machinarium%20Soundtrack/large&path=%2FNAS%2FRoyKent%2Fmachinarium-ost-mp3&metadata=false","duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","trackType":"mp3","channels":2}
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::startPlaybackTimer
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::seek
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: error: null
Dec 13 17:45:22 princess-leia volumio[828]: info:
Dec 13 17:45:22 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:22 princess-leia volumio[828]: info:
Dec 13 17:45:22 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:22 princess-leia volumio[828]: info:
Dec 13 17:45:22 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:22 princess-leia volumio[828]: info:
Dec 13 17:45:22 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand status took 4 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand status took 2 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand status took 2 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand status took 2 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:22 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:22 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:22 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:22 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:22 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:22 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:22 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:22 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService play
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus play
Dec 13 17:45:22 princess-leia volumio[828]: info: Received an update from plugin. extracting info from payload
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:22 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:22 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:22 princess-leia volumio[828]: info: ------------------------------ 32ms
Dec 13 17:45:22 princess-leia volumio[828]: info: ------------------------------ 30ms
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::volumioPause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::servicePause
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::servicePause
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::pause
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand pause
Dec 13 17:45:23 princess-leia volumio[828]: info:
Dec 13 17:45:23 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand pause took 4 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:23 princess-leia volumio[828]: info:
Dec 13 17:45:23 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:23 princess-leia volumio[828]: info:
Dec 13 17:45:23 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:23 princess-leia volumio[828]: info:
Dec 13 17:45:23 princess-leia volumio[828]: ---------------------------- MPD announces state update: player
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::getState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand status took 3 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand status took 2 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand status took 1 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand status took 1 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseState
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:23 princess-leia volumio[828]: verbose: ControllerMpd::parseTrackInfo
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":480,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:23 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":480,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:23 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":480,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:23 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:23 princess-leia volumio[828]: info: ControllerMpd::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::servicePushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":480,"duration":433,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Elevator","artist":"Tomas Dvorak","album":"Machinarium Soundtrack","uri":"NAS/RoyKent/machinarium-ost-mp3/13 The Elevator.mp3","trackType":"mp3"}
Dec 13 17:45:23 princess-leia volumio[828]: verbose: CURRENT POSITION 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState stateService pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::syncState currentStatus pause
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::pushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CorePlayQueue::getTrack 12
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreCommandRouter::volumioPushState
Dec 13 17:45:23 princess-leia volumio[828]: info: CoreStateMachine::stPlaybackTimer
Dec 13 17:45:23 princess-leia volumio[828]: info: ------------------------------ 21ms
Dec 13 17:45:23 princess-leia volumio[828]: info: ------------------------------ 20ms
Dec 13 17:45:23 princess-leia volumio[828]: info: ------------------------------ 20ms
Dec 13 17:45:23 princess-leia volumio[828]: info: ------------------------------ 20ms
Dec 13 17:45:28 princess-leia volumio[828]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 13 17:45:31 princess-leia volumio[828]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 13 17:45:31 princess-leia volumio[828]: info: FusionDsp - Stopping FusionDsp service
Dec 13 17:45:31 princess-leia volumio[828]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 13 17:45:31 princess-leia volumio[828]: TypeError: Cannot read property 'stop' of null
Dec 13 17:45:31 princess-leia volumio[828]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23)
Dec 13 17:45:31 princess-leia volumio[828]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Dec 13 17:45:31 princess-leia volumio[828]: at /volumio/app/pluginmanager.js:956:12
Dec 13 17:45:31 princess-leia volumio[828]: at ChildProcess.exithandler (child_process.js:299:7)
Dec 13 17:45:31 princess-leia volumio[828]: at ChildProcess.emit (events.js:315:20)
Dec 13 17:45:31 princess-leia volumio[828]: at maybeClose (internal/child_process.js:1048:16)
Dec 13 17:45:31 princess-leia volumio[828]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5)
Dec 13 17:45:31 princess-leia volumio[828]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 13 17:45:31 princess-leia sudo[5433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-13 17:44
Dec 13 17:45:31 princess-leia sudo[5433]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"