Oct 13 21:12:01 volumio-asus volumio[1297]: info: VolumeController::SetAlsaVolume72
Oct 13 21:12:01 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:12:01 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:12:01 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 13 21:12:01 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:12:01 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:12:01.199+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=5755 volume=72
Oct 13 21:12:01 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:12:01.200+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/SDisk/K2.1/Beautiful Female Voice 2/Beautiful Female Voice 2.flac.cue/track0005" title="05 - I'll Always Love You"
Oct 13 21:12:02 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 13 21:12:02 volumio-asus volumio[1297]: info: Received Get System Version
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 13 21:12:02 volumio-asus volumio[1297]: info: Received Get System Info
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 21:12:02 volumio-asus volumio[1297]: info: Discovery: Getting this device information
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioGetState
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 21:12:02 volumio-asus volumio[1297]: info: VolumeController::SetAlsaVolume79
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 13 21:12:02 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:12:02 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:12:02.367+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=7007 volume=79
Oct 13 21:12:02 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:12:02.368+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/SDisk/K2.1/Beautiful Female Voice 2/Beautiful Female Voice 2.flac.cue/track0005" title="05 - I'll Always Love You"
Oct 13 21:12:02 volumio-asus volumio[8105]: Traceback (most recent call last):
Oct 13 21:12:02 volumio-asus volumio[8105]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:02 volumio-asus volumio[8105]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:02 volumio-asus volumio[8105]: File "", line 424, in realpath
Oct 13 21:12:02 volumio-asus volumio[8105]: File "", line 468, in _joinrealpath
Oct 13 21:12:02 volumio-asus volumio[8105]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:02 volumio-asus volumio[8105]: The above exception was the direct cause of the following exception:
Oct 13 21:12:02 volumio-asus volumio[8105]: Traceback (most recent call last):
Oct 13 21:12:02 volumio-asus volumio[8105]: File "main.py", line 111, in
Oct 13 21:12:02 volumio-asus volumio[8105]: File "main.py", line 97, in main
Oct 13 21:12:02 volumio-asus volumio[8105]: File "main.py", line 37, in build_app
Oct 13 21:12:02 volumio-asus volumio[8105]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:02 volumio-asus volumio[8105]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:02 volumio-asus volumio[8105]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:02 volumio-asus volumio[8105]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:02 volumio-asus volumio[8105]: [PYI-8105:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:02 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:02 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:02 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.037s CPU time.
Oct 13 21:12:04 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 138.
Oct 13 21:12:04 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:04 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.037s CPU time.
Oct 13 21:12:04 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:09 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:10 volumio-asus volumio[8151]: Traceback (most recent call last):
Oct 13 21:12:10 volumio-asus volumio[8151]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:10 volumio-asus volumio[8151]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:10 volumio-asus volumio[8151]: File "", line 424, in realpath
Oct 13 21:12:10 volumio-asus volumio[8151]: File "", line 468, in _joinrealpath
Oct 13 21:12:10 volumio-asus volumio[8151]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:10 volumio-asus volumio[8151]: The above exception was the direct cause of the following exception:
Oct 13 21:12:10 volumio-asus volumio[8151]: Traceback (most recent call last):
Oct 13 21:12:10 volumio-asus volumio[8151]: File "main.py", line 111, in
Oct 13 21:12:10 volumio-asus volumio[8151]: File "main.py", line 97, in main
Oct 13 21:12:10 volumio-asus volumio[8151]: File "main.py", line 37, in build_app
Oct 13 21:12:10 volumio-asus volumio[8151]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:10 volumio-asus volumio[8151]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:10 volumio-asus volumio[8151]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:10 volumio-asus volumio[8151]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:10 volumio-asus volumio[8151]: [PYI-8151:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:10 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:10 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:10 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.032s CPU time.
Oct 13 21:12:12 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 139.
Oct 13 21:12:12 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:12 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.032s CPU time.
Oct 13 21:12:12 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:16 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 13 21:12:16 volumio-asus volumio[1297]: info: CURURI: artists://
Oct 13 21:12:16 volumio-asus volumio[1297]: info: Preload queue cleared
Oct 13 21:12:17 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:18 volumio-asus volumio[8196]: Traceback (most recent call last):
Oct 13 21:12:18 volumio-asus volumio[8196]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:18 volumio-asus volumio[8196]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:18 volumio-asus volumio[8196]: File "", line 424, in realpath
Oct 13 21:12:18 volumio-asus volumio[8196]: File "", line 468, in _joinrealpath
Oct 13 21:12:18 volumio-asus volumio[8196]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:18 volumio-asus volumio[8196]: The above exception was the direct cause of the following exception:
Oct 13 21:12:18 volumio-asus volumio[8196]: Traceback (most recent call last):
Oct 13 21:12:18 volumio-asus volumio[8196]: File "main.py", line 111, in
Oct 13 21:12:18 volumio-asus volumio[8196]: File "main.py", line 97, in main
Oct 13 21:12:18 volumio-asus volumio[8196]: File "main.py", line 37, in build_app
Oct 13 21:12:18 volumio-asus volumio[8196]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:18 volumio-asus volumio[8196]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:18 volumio-asus volumio[8196]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:18 volumio-asus volumio[8196]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:18 volumio-asus volumio[8196]: [PYI-8196:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:18 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:18 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:18 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.020s CPU time.
Oct 13 21:12:20 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 140.
Oct 13 21:12:20 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:20 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.020s CPU time.
Oct 13 21:12:20 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:25 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:25 volumio-asus volumio[8238]: Traceback (most recent call last):
Oct 13 21:12:25 volumio-asus volumio[8238]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:25 volumio-asus volumio[8238]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:25 volumio-asus volumio[8238]: File "", line 424, in realpath
Oct 13 21:12:25 volumio-asus volumio[8238]: File "", line 468, in _joinrealpath
Oct 13 21:12:25 volumio-asus volumio[8238]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:25 volumio-asus volumio[8238]: The above exception was the direct cause of the following exception:
Oct 13 21:12:25 volumio-asus volumio[8238]: Traceback (most recent call last):
Oct 13 21:12:25 volumio-asus volumio[8238]: File "main.py", line 111, in
Oct 13 21:12:25 volumio-asus volumio[8238]: File "main.py", line 97, in main
Oct 13 21:12:25 volumio-asus volumio[8238]: File "main.py", line 37, in build_app
Oct 13 21:12:25 volumio-asus volumio[8238]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:25 volumio-asus volumio[8238]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:25 volumio-asus volumio[8238]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:25 volumio-asus volumio[8238]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:25 volumio-asus volumio[8238]: [PYI-8238:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:26 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:26 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:26 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.046s CPU time.
Oct 13 21:12:28 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 141.
Oct 13 21:12:28 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:28 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.046s CPU time.
Oct 13 21:12:28 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:33 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:33 volumio-asus volumio[8269]: Traceback (most recent call last):
Oct 13 21:12:33 volumio-asus volumio[8269]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:33 volumio-asus volumio[8269]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:33 volumio-asus volumio[8269]: File "", line 424, in realpath
Oct 13 21:12:33 volumio-asus volumio[8269]: File "", line 468, in _joinrealpath
Oct 13 21:12:33 volumio-asus volumio[8269]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:33 volumio-asus volumio[8269]: The above exception was the direct cause of the following exception:
Oct 13 21:12:33 volumio-asus volumio[8269]: Traceback (most recent call last):
Oct 13 21:12:33 volumio-asus volumio[8269]: File "main.py", line 111, in
Oct 13 21:12:33 volumio-asus volumio[8269]: File "main.py", line 97, in main
Oct 13 21:12:33 volumio-asus volumio[8269]: File "main.py", line 37, in build_app
Oct 13 21:12:33 volumio-asus volumio[8269]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:33 volumio-asus volumio[8269]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:33 volumio-asus volumio[8269]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:33 volumio-asus volumio[8269]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:33 volumio-asus volumio[8269]: [PYI-8269:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:33 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:33 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:33 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.046s CPU time.
Oct 13 21:12:36 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 142.
Oct 13 21:12:36 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:36 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.046s CPU time.
Oct 13 21:12:36 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:41 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:41 volumio-asus volumio[8315]: Traceback (most recent call last):
Oct 13 21:12:41 volumio-asus volumio[8315]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:41 volumio-asus volumio[8315]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:41 volumio-asus volumio[8315]: File "", line 424, in realpath
Oct 13 21:12:41 volumio-asus volumio[8315]: File "", line 468, in _joinrealpath
Oct 13 21:12:41 volumio-asus volumio[8315]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:41 volumio-asus volumio[8315]: The above exception was the direct cause of the following exception:
Oct 13 21:12:41 volumio-asus volumio[8315]: Traceback (most recent call last):
Oct 13 21:12:41 volumio-asus volumio[8315]: File "main.py", line 111, in
Oct 13 21:12:41 volumio-asus volumio[8315]: File "main.py", line 97, in main
Oct 13 21:12:41 volumio-asus volumio[8315]: File "main.py", line 37, in build_app
Oct 13 21:12:41 volumio-asus volumio[8315]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:41 volumio-asus volumio[8315]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:41 volumio-asus volumio[8315]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:41 volumio-asus volumio[8315]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:41 volumio-asus volumio[8315]: [PYI-8315:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:41 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:41 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:41 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.010s CPU time.
Oct 13 21:12:43 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 143.
Oct 13 21:12:43 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:43 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.010s CPU time.
Oct 13 21:12:43 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:48 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:49 volumio-asus volumio[8360]: Traceback (most recent call last):
Oct 13 21:12:49 volumio-asus volumio[8360]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:49 volumio-asus volumio[8360]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:49 volumio-asus volumio[8360]: File "", line 424, in realpath
Oct 13 21:12:49 volumio-asus volumio[8360]: File "", line 468, in _joinrealpath
Oct 13 21:12:49 volumio-asus volumio[8360]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:49 volumio-asus volumio[8360]: The above exception was the direct cause of the following exception:
Oct 13 21:12:49 volumio-asus volumio[8360]: Traceback (most recent call last):
Oct 13 21:12:49 volumio-asus volumio[8360]: File "main.py", line 111, in
Oct 13 21:12:49 volumio-asus volumio[8360]: File "main.py", line 97, in main
Oct 13 21:12:49 volumio-asus volumio[8360]: File "main.py", line 37, in build_app
Oct 13 21:12:49 volumio-asus volumio[8360]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:49 volumio-asus volumio[8360]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:49 volumio-asus volumio[8360]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:49 volumio-asus volumio[8360]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:49 volumio-asus volumio[8360]: [PYI-8360:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:49 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:49 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:49 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.041s CPU time.
Oct 13 21:12:51 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 144.
Oct 13 21:12:51 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:51 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.041s CPU time.
Oct 13 21:12:51 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:12:56 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:57 volumio-asus volumio[8407]: Traceback (most recent call last):
Oct 13 21:12:57 volumio-asus volumio[8407]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:12:57 volumio-asus volumio[8407]: File "pathlib.py", line 1240, in resolve
Oct 13 21:12:57 volumio-asus volumio[8407]: File "", line 424, in realpath
Oct 13 21:12:57 volumio-asus volumio[8407]: File "", line 468, in _joinrealpath
Oct 13 21:12:57 volumio-asus volumio[8407]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:12:57 volumio-asus volumio[8407]: The above exception was the direct cause of the following exception:
Oct 13 21:12:57 volumio-asus volumio[8407]: Traceback (most recent call last):
Oct 13 21:12:57 volumio-asus volumio[8407]: File "main.py", line 111, in
Oct 13 21:12:57 volumio-asus volumio[8407]: File "main.py", line 97, in main
Oct 13 21:12:57 volumio-asus volumio[8407]: File "main.py", line 37, in build_app
Oct 13 21:12:57 volumio-asus volumio[8407]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:12:57 volumio-asus volumio[8407]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:12:57 volumio-asus volumio[8407]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:12:57 volumio-asus volumio[8407]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:12:57 volumio-asus volumio[8407]: [PYI-8407:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:12:57 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:12:57 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:12:57 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.019s CPU time.
Oct 13 21:12:59 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 145.
Oct 13 21:12:59 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:12:59 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.019s CPU time.
Oct 13 21:12:59 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:04 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:05 volumio-asus volumio[8451]: Traceback (most recent call last):
Oct 13 21:13:05 volumio-asus volumio[8451]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:13:05 volumio-asus volumio[8451]: File "pathlib.py", line 1240, in resolve
Oct 13 21:13:05 volumio-asus volumio[8451]: File "", line 424, in realpath
Oct 13 21:13:05 volumio-asus volumio[8451]: File "", line 468, in _joinrealpath
Oct 13 21:13:05 volumio-asus volumio[8451]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:13:05 volumio-asus volumio[8451]: The above exception was the direct cause of the following exception:
Oct 13 21:13:05 volumio-asus volumio[8451]: Traceback (most recent call last):
Oct 13 21:13:05 volumio-asus volumio[8451]: File "main.py", line 111, in
Oct 13 21:13:05 volumio-asus volumio[8451]: File "main.py", line 97, in main
Oct 13 21:13:05 volumio-asus volumio[8451]: File "main.py", line 37, in build_app
Oct 13 21:13:05 volumio-asus volumio[8451]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:13:05 volumio-asus volumio[8451]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:13:05 volumio-asus volumio[8451]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:13:05 volumio-asus volumio[8451]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:13:05 volumio-asus volumio[8451]: [PYI-8451:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:13:05 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:13:05 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:13:05 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.026s CPU time.
Oct 13 21:13:07 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 146.
Oct 13 21:13:07 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:07 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.026s CPU time.
Oct 13 21:13:07 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Preload queue cleared
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::ClearQueue
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::stPlaybackTimer
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::updateTrackBlock
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrackBlock
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::serviceStop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::serviceStop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::stop
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::clearPlayQueue
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::saveQueue
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushQueue
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::addQueueItems
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::addQueueItems
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Preload queue cleared
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Adding Item to queue: artists://SACD%20COLLECTION%20HITS
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Exploding uri artists://SACD%20COLLECTION%20HITS in service mpd
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.607+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=79
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.607+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/SDisk/K2.1/Beautiful Female Voice 2/Beautiful Female Voice 2.flac.cue/track0005" title="05 - I'll Always Love You"
Oct 13 21:13:09 volumio-asus volumio[1297]: info: FusionDsp - Volumio is not playing
Oct 13 21:13:09 volumio-asus volumio[1297]: info: FusionDsp - Clipped samples monitor stopped
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand stop took 6 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushQueue
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::saveQueue
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::updateTrackBlock
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrackBlock
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPlay
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::play index 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::play index undefined
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::startPlaybackTimer
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Setting Volume to 100 automatically for DSD
Oct 13 21:13:09 volumio-asus volumio[1297]: info: VolumeController::SetAlsaVolume100
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.626+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.627+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 18 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand stop took 8 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand clear
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand clear took 2 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 2 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 2 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 1 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf"
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I'll Always Love You","artist":"Jheena Lodwick","album":"Beautiful Female Voice 2","uri":"INTERNAL/SDisk/K2.1/Beautiful Female Voice 2/Beautiful Female Voice 2.flac.cue/track0005","trackType":""}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: No code
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: No code
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: No code
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: No code
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.653+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.653+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.653+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.653+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.654+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.654+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.654+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.654+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.655+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 47ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 27ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 27ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 27ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.659+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.659+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.659+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_STOPPED positionMs=0 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.660+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio[1297]: error: updateQueue error: null
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 30ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand add "INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" took 29 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 4ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 3ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 3ms
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand play
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces system playlist update
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Ignoring MPD Status Update
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 28ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand play took 27 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 27ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 27ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 26ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 9 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 9 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 9 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 9 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info:
Oct 13 21:13:09 volumio-asus volumio[1297]: ---------------------------- MPD announces state update: player
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::getState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 4 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 2 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 6 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand status took 6 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseState
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus stop
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 28ms
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.723+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.724+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.725+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.725+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.725+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 32ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 32ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 32ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 17 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 17 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 16 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: info: sendMpdCommand playlistinfo took 16 milliseconds
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: ControllerMpd::parseTrackInfo
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ControllerMpd::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::servicePushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":207,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Whom I Love Most","artist":"SACD COLLECTION HITS","album":"SACD COLLECTION HITS","uri":"INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf","trackType":"dsf"}
Oct 13 21:13:09 volumio-asus volumio[1297]: verbose: CURRENT POSITION 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState stateService play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::syncState currentStatus play
Oct 13 21:13:09 volumio-asus volumio[1297]: info: Received an update from plugin. extracting info from payload
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreStateMachine::pushState
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CorePlayQueue::getTrack 0
Oct 13 21:13:09 volumio-asus volumio[1297]: info: CoreCommandRouter::volumioPushState
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.749+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.749+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.749+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" state=STATUS_PLAYING positionMs=364 volume=100
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.750+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 49ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 48ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 48ms
Oct 13 21:13:09 volumio-asus volumio[1297]: info: ------------------------------ 48ms
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.755+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.755+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio5-onboarding[1914]: time=2026-10-13T21:13:09.755+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.125:59589,00:00:00:00:00:00%03 @ 0xc0001ecf00" id="music-library/INTERNAL/DSD/Lam George 林子祥/林子祥 SACD Collections/01 - 最愛是誰.dsf" title="1 - Whom I Love Most"
Oct 13 21:13:09 volumio-asus volumio[1297]: info: FusionDsp - Volumio is playing
Oct 13 21:13:09 volumio-asus volumio[1297]: warn: FusionDsp - Monitor WebSocket not open, skipping commands
Oct 13 21:13:09 volumio-asus volumio[1297]: info: FusionDsp - Clipping Monitor started
Oct 13 21:13:09 volumio-asus volumio[1297]: info: FusionDsp - ---- read samplerate, raw: 352800,S32_LE,2,32
Oct 13 21:13:09 volumio-asus volumio[1297]: info: FusionDsp - ---- read samplerate from file: 352800
Oct 13 21:13:09 volumio-asus volumio[1297]: info: camilladsp stopping service pid 7645...
Oct 13 21:13:10 volumio-asus volumio[1297]: info: camilladsp service terminated, instance 1
Oct 13 21:13:10 volumio-asus volumio[1297]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Oct 13 21:13:10 volumio-asus volumio[1297]: info: camilladsp service started and running in background, instance 1
Oct 13 21:13:10 volumio-asus volumio[1297]: info: FusionDsp - Clipping Monitor reconnecting in 2000ms
Oct 13 21:13:12 volumio-asus volumio[1297]: info: FusionDsp - Clipping Monitor started
Oct 13 21:13:12 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:13 volumio-asus volumio[8509]: Traceback (most recent call last):
Oct 13 21:13:13 volumio-asus volumio[8509]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:13:13 volumio-asus volumio[8509]: File "pathlib.py", line 1240, in resolve
Oct 13 21:13:13 volumio-asus volumio[8509]: File "", line 424, in realpath
Oct 13 21:13:13 volumio-asus volumio[8509]: File "", line 468, in _joinrealpath
Oct 13 21:13:13 volumio-asus volumio[8509]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:13:13 volumio-asus volumio[8509]: The above exception was the direct cause of the following exception:
Oct 13 21:13:13 volumio-asus volumio[8509]: Traceback (most recent call last):
Oct 13 21:13:13 volumio-asus volumio[8509]: File "main.py", line 111, in
Oct 13 21:13:13 volumio-asus volumio[8509]: File "main.py", line 97, in main
Oct 13 21:13:13 volumio-asus volumio[8509]: File "main.py", line 37, in build_app
Oct 13 21:13:13 volumio-asus volumio[8509]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:13:13 volumio-asus volumio[8509]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:13:13 volumio-asus volumio[8509]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:13:13 volumio-asus volumio[8509]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:13:13 volumio-asus volumio[8509]: [PYI-8509:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:13:13 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:13:13 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:13:13 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.012s CPU time.
Oct 13 21:13:15 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 147.
Oct 13 21:13:15 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:15 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.012s CPU time.
Oct 13 21:13:15 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:20 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:21 volumio-asus volumio[8551]: Traceback (most recent call last):
Oct 13 21:13:21 volumio-asus volumio[8551]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:13:21 volumio-asus volumio[8551]: File "pathlib.py", line 1240, in resolve
Oct 13 21:13:21 volumio-asus volumio[8551]: File "", line 424, in realpath
Oct 13 21:13:21 volumio-asus volumio[8551]: File "", line 468, in _joinrealpath
Oct 13 21:13:21 volumio-asus volumio[8551]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:13:21 volumio-asus volumio[8551]: The above exception was the direct cause of the following exception:
Oct 13 21:13:21 volumio-asus volumio[8551]: Traceback (most recent call last):
Oct 13 21:13:21 volumio-asus volumio[8551]: File "main.py", line 111, in
Oct 13 21:13:21 volumio-asus volumio[8551]: File "main.py", line 97, in main
Oct 13 21:13:21 volumio-asus volumio[8551]: File "main.py", line 37, in build_app
Oct 13 21:13:21 volumio-asus volumio[8551]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:13:21 volumio-asus volumio[8551]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:13:21 volumio-asus volumio[8551]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:13:21 volumio-asus volumio[8551]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:13:21 volumio-asus volumio[8551]: [PYI-8551:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:13:21 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:13:21 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:13:21 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.020s CPU time.
Oct 13 21:13:23 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 148.
Oct 13 21:13:23 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:23 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.020s CPU time.
Oct 13 21:13:23 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:28 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:29 volumio-asus volumio[8597]: Traceback (most recent call last):
Oct 13 21:13:29 volumio-asus volumio[8597]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:13:29 volumio-asus volumio[8597]: File "pathlib.py", line 1240, in resolve
Oct 13 21:13:29 volumio-asus volumio[8597]: File "", line 424, in realpath
Oct 13 21:13:29 volumio-asus volumio[8597]: File "", line 468, in _joinrealpath
Oct 13 21:13:29 volumio-asus volumio[8597]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:13:29 volumio-asus volumio[8597]: The above exception was the direct cause of the following exception:
Oct 13 21:13:29 volumio-asus volumio[8597]: Traceback (most recent call last):
Oct 13 21:13:29 volumio-asus volumio[8597]: File "main.py", line 111, in
Oct 13 21:13:29 volumio-asus volumio[8597]: File "main.py", line 97, in main
Oct 13 21:13:29 volumio-asus volumio[8597]: File "main.py", line 37, in build_app
Oct 13 21:13:29 volumio-asus volumio[8597]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:13:29 volumio-asus volumio[8597]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:13:29 volumio-asus volumio[8597]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:13:29 volumio-asus volumio[8597]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:13:29 volumio-asus volumio[8597]: [PYI-8597:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:13:29 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:13:29 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:13:29 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.021s CPU time.
Oct 13 21:13:31 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 149.
Oct 13 21:13:31 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:31 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.021s CPU time.
Oct 13 21:13:31 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:36 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:37 volumio-asus volumio[8640]: Traceback (most recent call last):
Oct 13 21:13:37 volumio-asus volumio[8640]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:13:37 volumio-asus volumio[8640]: File "pathlib.py", line 1240, in resolve
Oct 13 21:13:37 volumio-asus volumio[8640]: File "", line 424, in realpath
Oct 13 21:13:37 volumio-asus volumio[8640]: File "", line 468, in _joinrealpath
Oct 13 21:13:37 volumio-asus volumio[8640]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:13:37 volumio-asus volumio[8640]: The above exception was the direct cause of the following exception:
Oct 13 21:13:37 volumio-asus volumio[8640]: Traceback (most recent call last):
Oct 13 21:13:37 volumio-asus volumio[8640]: File "main.py", line 111, in
Oct 13 21:13:37 volumio-asus volumio[8640]: File "main.py", line 97, in main
Oct 13 21:13:37 volumio-asus volumio[8640]: File "main.py", line 37, in build_app
Oct 13 21:13:37 volumio-asus volumio[8640]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:13:37 volumio-asus volumio[8640]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:13:37 volumio-asus volumio[8640]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:13:37 volumio-asus volumio[8640]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:13:37 volumio-asus volumio[8640]: [PYI-8640:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:13:37 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:13:37 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:13:37 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.026s CPU time.
Oct 13 21:13:39 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 150.
Oct 13 21:13:39 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:39 volumio-asus systemd[1]: fusiondsp.service: Consumed 1.026s CPU time.
Oct 13 21:13:39 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:44 volumio-asus systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:45 volumio-asus volumio[8671]: Traceback (most recent call last):
Oct 13 21:13:45 volumio-asus volumio[8671]: File "aiohttp/web_urldispatcher.py", line 568, in __init__
Oct 13 21:13:45 volumio-asus volumio[8671]: File "pathlib.py", line 1240, in resolve
Oct 13 21:13:45 volumio-asus volumio[8671]: File "", line 424, in realpath
Oct 13 21:13:45 volumio-asus volumio[8671]: File "", line 468, in _joinrealpath
Oct 13 21:13:45 volumio-asus volumio[8671]: FileNotFoundError: [Errno 2] No such file or directory: '/data/INTERNAL/FusionDsp'
Oct 13 21:13:45 volumio-asus volumio[8671]: The above exception was the direct cause of the following exception:
Oct 13 21:13:45 volumio-asus volumio[8671]: Traceback (most recent call last):
Oct 13 21:13:45 volumio-asus volumio[8671]: File "main.py", line 111, in
Oct 13 21:13:45 volumio-asus volumio[8671]: File "main.py", line 97, in main
Oct 13 21:13:45 volumio-asus volumio[8671]: File "main.py", line 37, in build_app
Oct 13 21:13:45 volumio-asus volumio[8671]: File "backend/routes.py", line 105, in setup_static_routes
Oct 13 21:13:45 volumio-asus volumio[8671]: File "aiohttp/web_urldispatcher.py", line 1211, in add_static
Oct 13 21:13:45 volumio-asus volumio[8671]: File "aiohttp/web_urldispatcher.py", line 570, in __init__
Oct 13 21:13:45 volumio-asus volumio[8671]: ValueError: '/data/INTERNAL/FusionDsp/filters' does not exist
Oct 13 21:13:45 volumio-asus volumio[8671]: [PYI-8671:ERROR] Failed to execute script 'main' due to unhandled exception!
Oct 13 21:13:45 volumio-asus systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Oct 13 21:13:45 volumio-asus systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Oct 13 21:13:47 volumio-asus systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 151.
Oct 13 21:13:47 volumio-asus systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon.
Oct 13 21:13:47 volumio-asus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon...
Oct 13 21:13:47 volumio-asus volumio[1297]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 13 21:13:47 volumio-asus volumio[1297]: TypeError: Cannot read properties of null (reading 'slice')
Oct 13 21:13:47 volumio-asus volumio[1297]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Oct 13 21:13:47 volumio-asus volumio[1297]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Oct 13 21:13:47 volumio-asus volumio[1297]: at Object.onceWrapper (node:events:629:26)
Oct 13 21:13:47 volumio-asus volumio[1297]: at ClientRequest.emit (node:events:514:28)
Oct 13 21:13:47 volumio-asus volumio[1297]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Oct 13 21:13:47 volumio-asus volumio[1297]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Oct 13 21:13:47 volumio-asus volumio[1297]: at TLSSocket.socketOnData (node:_http_client:535:22)
Oct 13 21:13:47 volumio-asus volumio[1297]: at TLSSocket.emit (node:events:514:28)
Oct 13 21:13:47 volumio-asus volumio[1297]: at addChunk (node:internal/streams/readable:343:12)
Oct 13 21:13:47 volumio-asus volumio[1297]: at readableAddChunk (node:internal/streams/readable:316:9)
Oct 13 21:13:47 volumio-asus volumio[1297]: at Readable.push (node:internal/streams/readable:253:10)
Oct 13 21:13:47 volumio-asus volumio[1297]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Oct 13 21:13:47 volumio-asus volumio[1297]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 13 21:13:47 volumio-asus sudo[8715]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 21:12'
Oct 13 21:13:47 volumio-asus sudo[8715]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"