-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-11-29 18:46:16 CET. -- Nov 29 18:45:00 volumio volumio[739]: info: camilladsp spawned new process with pid 14480, instance 1, run: true Nov 29 18:45:00 volumio volumio[739]: info: camilladsp spawned new process with pid 14487, instance 1, run: true Nov 29 18:45:00 volumio volumio[739]: info: camilladsp spawned new process with pid 14494, instance 1, run: true Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14501, instance 1, run: true Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14508, instance 1, run: true Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14515, instance 1, run: true Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14522, instance 1, run: true Nov 29 18:45:01 volumio go-librespot[967]: time="2024-11-29T18:45:01+01:00" level=debug msg="fetched chunk 21/21, size: 92504" uri="spotify:track:3cxAKEcgwYYLVUiKslkzSw" Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14529, instance 1, run: true Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14536, instance 1, run: true Nov 29 18:45:01 volumio volumio[739]: info: camilladsp spawned new process with pid 14543, instance 1, run: true Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14550, instance 1, run: true Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14557, instance 1, run: true Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14564, instance 1, run: true Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14571, instance 1, run: true Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14580, instance 1, run: true Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14587, instance 1, run: true Nov 29 18:45:02 volumio volumio[14479]: Traceback (most recent call last): Nov 29 18:45:02 volumio volumio[14479]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Nov 29 18:45:02 volumio volumio[14479]: from camilladsp import CamillaConnection Nov 29 18:45:02 volumio volumio[14479]: ModuleNotFoundError: No module named 'camilladsp' Nov 29 18:45:02 volumio volumio[739]: info: camilladsp spawned new process with pid 14594, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14601, instance 1, run: true Nov 29 18:45:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14608, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14615, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14622, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14629, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14636, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14643, instance 1, run: true Nov 29 18:45:03 volumio volumio[739]: info: camilladsp spawned new process with pid 14650, instance 1, run: true Nov 29 18:45:04 volumio volumio[739]: info: camilladsp spawned new process with pid 14657, instance 1, run: true Nov 29 18:45:04 volumio volumio[739]: info: Collecting PyYAML (from camilladsp==1.0.0) Nov 29 18:45:04 volumio volumio[739]: info: Collecting PyYAML (from camilladsp==1.0.0) Nov 29 18:45:04 volumio volumio[739]: info: camilladsp spawned new process with pid 14664, instance 1, run: true Nov 29 18:45:04 volumio volumio[739]: info: camilladsp spawned new process with pid 14671, instance 1, run: true Nov 29 18:45:04 volumio volumio[739]: info: camilladsp spawned new process with pid 14678, instance 1, run: true Nov 29 18:45:04 volumio volumio[739]: info: camilladsp spawned new process with pid 14685, instance 1, run: true Nov 29 18:45:04 volumio volumio[739]: info: camilladsp spawned new process with pid 14692, instance 1, run: true Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14699, instance 1, run: true Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14706, instance 1, run: true Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14713, instance 1, run: true Nov 29 18:45:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 65. Nov 29 18:45:05 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14721, instance 1, run: true Nov 29 18:45:05 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14728, instance 1, run: true Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14735, instance 1, run: true Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14742, instance 1, run: true Nov 29 18:45:05 volumio volumio[739]: info: camilladsp spawned new process with pid 14749, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14756, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14763, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14770, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14777, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14784, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14792, instance 1, run: true Nov 29 18:45:06 volumio volumio[739]: info: camilladsp spawned new process with pid 14799, instance 1, run: true Nov 29 18:45:07 volumio volumio[739]: info: camilladsp spawned new process with pid 14806, instance 1, run: true Nov 29 18:45:07 volumio volumio[739]: info: camilladsp spawned new process with pid 14813, instance 1, run: true Nov 29 18:45:07 volumio volumio[739]: info: camilladsp spawned new process with pid 14820, instance 1, run: true Nov 29 18:45:07 volumio volumio[739]: info: camilladsp spawned new process with pid 14827, instance 1, run: true Nov 29 18:45:07 volumio volumio[739]: info: camilladsp spawned new process with pid 14834, instance 1, run: true Nov 29 18:45:07 volumio volumio[14720]: Traceback (most recent call last): Nov 29 18:45:07 volumio volumio[14720]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Nov 29 18:45:07 volumio volumio[14720]: from camilladsp import CamillaConnection Nov 29 18:45:07 volumio volumio[14720]: ModuleNotFoundError: No module named 'camilladsp' Nov 29 18:45:07 volumio volumio[739]: info: camilladsp spawned new process with pid 14841, instance 1, run: true Nov 29 18:45:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14848, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14855, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14862, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14869, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14876, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14883, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14890, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: camilladsp spawned new process with pid 14897, instance 1, run: true Nov 29 18:45:08 volumio volumio[739]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Nov 29 18:45:08 volumio volumio[739]: info: Downloading https://www.piwheels.org/simple/pyyaml/PyYAML-6.0.1-cp37-cp37m-linux_armv7l.whl (45kB) Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14904, instance 1, run: true Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14911, instance 1, run: true Nov 29 18:45:09 volumio volumio[739]: info: Collecting websocket_client (from camilladsp==1.0.0) Nov 29 18:45:09 volumio volumio[739]: info: Collecting websocket_client (from camilladsp==1.0.0) Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14918, instance 1, run: true Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14925, instance 1, run: true Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14932, instance 1, run: true Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14939, instance 1, run: true Nov 29 18:45:09 volumio volumio[739]: info: camilladsp spawned new process with pid 14946, instance 1, run: true Nov 29 18:45:10 volumio volumio[739]: info: camilladsp spawned new process with pid 14953, instance 1, run: true Nov 29 18:45:10 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:10 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 66. Nov 29 18:45:10 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:10 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:10 volumio volumio[739]: info: camilladsp spawned new process with pid 14961, instance 1, run: true Nov 29 18:45:10 volumio volumio[739]: info: camilladsp spawned new process with pid 14968, instance 1, run: true Nov 29 18:45:10 volumio volumio[739]: info: camilladsp spawned new process with pid 14975, instance 1, run: true Nov 29 18:45:10 volumio volumio[739]: info: camilladsp spawned new process with pid 14982, instance 1, run: true Nov 29 18:45:10 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Nov 29 18:45:10 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/d3/a3/63e9329c8cc9be6153e919e17d0ef5b60d537fed78564872951b95bcc17c/websocket_client-1.6.1-py3-none-any.whl (56kB) Nov 29 18:45:10 volumio volumio[739]: info: camilladsp spawned new process with pid 14989, instance 1, run: true Nov 29 18:45:11 volumio volumio[739]: info: camilladsp spawned new process with pid 14996, instance 1, run: true Nov 29 18:45:11 volumio volumio[739]: info: Building wheels for collected packages: camilladsp Nov 29 18:45:11 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp: started Nov 29 18:45:11 volumio volumio[739]: info: Building wheels for collected packages: camilladsp Nov 29 18:45:11 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp: started Nov 29 18:45:11 volumio volumio[739]: info: camilladsp spawned new process with pid 15004, instance 1, run: true Nov 29 18:45:11 volumio volumio[739]: info: camilladsp spawned new process with pid 15011, instance 1, run: true Nov 29 18:45:11 volumio volumio[739]: info: camilladsp spawned new process with pid 15018, instance 1, run: true Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15025, instance 1, run: true Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15032, instance 1, run: true Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15039, instance 1, run: true Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15046, instance 1, run: true Nov 29 18:45:12 volumio volumio[14960]: Traceback (most recent call last): Nov 29 18:45:12 volumio volumio[14960]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Nov 29 18:45:12 volumio volumio[14960]: from camilladsp import CamillaConnection Nov 29 18:45:12 volumio volumio[14960]: ModuleNotFoundError: No module named 'camilladsp' Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15053, instance 1, run: true Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15060, instance 1, run: true Nov 29 18:45:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:12 volumio volumio[739]: info: camilladsp spawned new process with pid 15067, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15076, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15083, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15090, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15097, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15104, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15111, instance 1, run: true Nov 29 18:45:13 volumio volumio[739]: info: camilladsp spawned new process with pid 15118, instance 1, run: true Nov 29 18:45:14 volumio volumio[739]: info: camilladsp spawned new process with pid 15125, instance 1, run: true Nov 29 18:45:14 volumio volumio[739]: info: camilladsp spawned new process with pid 15132, instance 1, run: true Nov 29 18:45:14 volumio volumio[739]: info: camilladsp spawned new process with pid 15139, instance 1, run: true Nov 29 18:45:14 volumio volumio[739]: info: camilladsp spawned new process with pid 15146, instance 1, run: true Nov 29 18:45:14 volumio volumio[739]: info: camilladsp spawned new process with pid 15153, instance 1, run: true Nov 29 18:45:14 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Nov 29 18:45:14 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Nov 29 18:45:14 volumio volumio[739]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-x5h8mup3/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Nov 29 18:45:14 volumio volumio[739]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-x5h8mup3/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Nov 29 18:45:14 volumio volumio[739]: info: camilladsp spawned new process with pid 15160, instance 1, run: true Nov 29 18:45:15 volumio volumio[739]: info: Successfully built camilladsp Nov 29 18:45:15 volumio volumio[739]: info: Successfully built camilladsp Nov 29 18:45:15 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:15 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 67. Nov 29 18:45:15 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:15 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:15 volumio volumio[739]: info: camilladsp spawned new process with pid 15168, instance 1, run: true Nov 29 18:45:15 volumio volumio[739]: info: camilladsp spawned new process with pid 15175, instance 1, run: true Nov 29 18:45:15 volumio volumio[739]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Nov 29 18:45:15 volumio volumio[739]: info: Installing collected packages: PyYAML, websocket-client, camilladsp Nov 29 18:45:16 volumio volumio[739]: info: camilladsp spawned new process with pid 15182, instance 1, run: true Nov 29 18:45:16 volumio volumio[739]: info: camilladsp spawned new process with pid 15189, instance 1, run: true Nov 29 18:45:16 volumio volumio[739]: info: camilladsp spawned new process with pid 15196, instance 1, run: true Nov 29 18:45:16 volumio volumio[739]: info: camilladsp spawned new process with pid 15203, instance 1, run: true Nov 29 18:45:16 volumio volumio[739]: info: camilladsp spawned new process with pid 15210, instance 1, run: true Nov 29 18:45:16 volumio volumio[739]: info: camilladsp spawned new process with pid 15218, instance 1, run: true Nov 29 18:45:16 volumio volumio[739]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Nov 29 18:45:17 volumio volumio[739]: info: Successfully installed PyYAML-6.0.1 camilladsp-1.0.0 websocket-client-1.6.1 Nov 29 18:45:17 volumio volumio[739]: info: camilladsp spawned new process with pid 15225, instance 1, run: true Nov 29 18:45:17 volumio volumio[739]: info: camilladsp spawned new process with pid 15232, instance 1, run: true Nov 29 18:45:17 volumio volumio[739]: info: camilladsp spawned new process with pid 15240, instance 1, run: true Nov 29 18:45:17 volumio volumio[15167]: Traceback (most recent call last): Nov 29 18:45:17 volumio volumio[15167]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Nov 29 18:45:17 volumio volumio[15167]: from camilladsp import CamillaConnection Nov 29 18:45:17 volumio volumio[15167]: ModuleNotFoundError: No module named 'camilladsp' Nov 29 18:45:17 volumio volumio[739]: info: camilladsp spawned new process with pid 15247, instance 1, run: true Nov 29 18:45:17 volumio volumio[739]: info: camilladsp spawned new process with pid 15254, instance 1, run: true Nov 29 18:45:17 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:17 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15261, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15268, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15275, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15282, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15289, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15296, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15303, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15310, instance 1, run: true Nov 29 18:45:18 volumio volumio[739]: info: camilladsp spawned new process with pid 15317, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15324, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15331, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15338, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15345, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15352, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15359, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15366, instance 1, run: true Nov 29 18:45:19 volumio volumio[739]: info: camilladsp spawned new process with pid 15373, instance 1, run: true Nov 29 18:45:20 volumio volumio[739]: info: camilladsp spawned new process with pid 15380, instance 1, run: true Nov 29 18:45:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 68. Nov 29 18:45:20 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:20 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:20 volumio volumio[739]: info: camilladsp spawned new process with pid 15388, instance 1, run: true Nov 29 18:45:20 volumio volumio[739]: info: camilladsp spawned new process with pid 15395, instance 1, run: true Nov 29 18:45:20 volumio volumio[739]: info: camilladsp spawned new process with pid 15402, instance 1, run: true Nov 29 18:45:20 volumio volumio[739]: info: camilladsp spawned new process with pid 15409, instance 1, run: true Nov 29 18:45:20 volumio volumio[739]: info: camilladsp spawned new process with pid 15417, instance 1, run: true Nov 29 18:45:21 volumio volumio[739]: info: camilladsp spawned new process with pid 15442, instance 1, run: true Nov 29 18:45:21 volumio volumio[739]: info: camilladsp spawned new process with pid 15467, instance 1, run: true Nov 29 18:45:21 volumio volumio[739]: info: camilladsp spawned new process with pid 15490, instance 1, run: true Nov 29 18:45:21 volumio go-librespot[967]: time="2024-11-29T18:45:21+01:00" level=debug msg="prefetching next track" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:21 volumio go-librespot[967]: time="2024-11-29T18:45:21+01:00" level=debug msg="selected format OGG_VORBIS_320 (e0981d4132de84750e43c4daade4af40f278ac45)" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:21 volumio go-librespot[967]: time="2024-11-29T18:45:21+01:00" level=debug msg="requested aes key for file e0981d4132de84750e43c4daade4af40f278ac45, gid: 0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:21 volumio volumio[739]: info: camilladsp spawned new process with pid 15497, instance 1, run: true Nov 29 18:45:21 volumio volumio[739]: info: camilladsp spawned new process with pid 15504, instance 1, run: true Nov 29 18:45:21 volumio volumio[739]: info: camilladsp spawned new process with pid 15511, instance 1, run: true Nov 29 18:45:21 volumio go-librespot[967]: time="2024-11-29T18:45:21+01:00" level=debug msg="fetched first chunk of 21, total size is 10518936 bytes" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:21 volumio go-librespot[967]: time="2024-11-29T18:45:21+01:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:22 volumio go-librespot[967]: time="2024-11-29T18:45:22+01:00" level=info msg="prefetched track \"This Fire of Autumn\" (duration: 257253ms)" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:22 volumio volumio[739]: info: camilladsp spawned new process with pid 15518, instance 1, run: true Nov 29 18:45:22 volumio volumio[739]: info: camilladsp spawned new process with pid 15525, instance 1, run: true Nov 29 18:45:22 volumio go-librespot[967]: time="2024-11-29T18:45:22+01:00" level=debug msg="fetched chunk 2/20, size: 524288" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:22 volumio volumio[739]: info: camilladsp spawned new process with pid 15532, instance 1, run: true Nov 29 18:45:22 volumio go-librespot[967]: time="2024-11-29T18:45:22+01:00" level=debug msg="fetched chunk 3/20, size: 524288" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:22 volumio go-librespot[967]: time="2024-11-29T18:45:22+01:00" level=debug msg="fetched chunk 1/20, size: 524288" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:22 volumio volumio[739]: info: camilladsp spawned new process with pid 15539, instance 1, run: true Nov 29 18:45:22 volumio volumio[739]: info: camilladsp spawned new process with pid 15546, instance 1, run: true Nov 29 18:45:22 volumio volumio[739]: info: camilladsp spawned new process with pid 15553, instance 1, run: true Nov 29 18:45:22 volumio volumio[15387]: Traceback (most recent call last): Nov 29 18:45:22 volumio volumio[15387]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:22 volumio volumio[15387]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:22 volumio volumio[15387]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:23 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:23 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:23 volumio volumio[739]: verbose: New Socket.io Connection to 192.168.1.59:3000 from 192.168.1.48 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Nov 29 18:45:23 volumio volumio[739]: info: camilladsp spawned new process with pid 15560, instance 1, run: true Nov 29 18:45:23 volumio volumio[739]: info: camilladsp spawned new process with pid 15567, instance 1, run: true Nov 29 18:45:23 volumio volumio[739]: info: camilladsp spawned new process with pid 15574, instance 1, run: true Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 29 18:45:23 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 29 18:45:23 volumio volumio[739]: info: camilladsp spawned new process with pid 15581, instance 1, run: true Nov 29 18:45:23 volumio volumio[739]: info: camilladsp spawned new process with pid 15588, instance 1, run: true Nov 29 18:45:23 volumio volumio[739]: info: camilladsp spawned new process with pid 15595, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15602, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15609, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15616, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15623, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15630, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15637, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15644, instance 1, run: true Nov 29 18:45:24 volumio volumio[739]: info: camilladsp spawned new process with pid 15651, instance 1, run: true Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15658, instance 1, run: true Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15665, instance 1, run: true Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15672, instance 1, run: true Nov 29 18:45:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 69. Nov 29 18:45:25 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:25 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15680, instance 1, run: true Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15687, instance 1, run: true Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15694, instance 1, run: true Nov 29 18:45:25 volumio volumio[739]: info: camilladsp spawned new process with pid 15701, instance 1, run: true Nov 29 18:45:26 volumio sudo[15709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 29 18:45:26 volumio sudo[15709]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:45:26 volumio sudo[15709]: pam_unix(sudo:session): session closed for user root Nov 29 18:45:26 volumio volumio[739]: info: camilladsp spawned new process with pid 15712, instance 1, run: true Nov 29 18:45:26 volumio sudo[15711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 29 18:45:26 volumio sudo[15711]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:45:26 volumio sudo[15711]: pam_unix(sudo:session): session closed for user root Nov 29 18:45:26 volumio volumio[739]: verbose: New Socket.io Connection to 192.168.1.59 from 192.168.1.48 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Nov 29 18:45:26 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 29 18:45:26 volumio volumio[739]: info: camilladsp spawned new process with pid 15723, instance 1, run: true Nov 29 18:45:26 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 29 18:45:26 volumio volumio[739]: info: camilladsp spawned new process with pid 15731, instance 1, run: true Nov 29 18:45:26 volumio volumio[739]: info: camilladsp spawned new process with pid 15738, instance 1, run: true Nov 29 18:45:27 volumio sudo[15746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 29 18:45:27 volumio sudo[15746]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:45:27 volumio sudo[15746]: pam_unix(sudo:session): session closed for user root Nov 29 18:45:27 volumio sudo[15749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 29 18:45:27 volumio sudo[15749]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:45:27 volumio volumio[739]: info: camilladsp spawned new process with pid 15750, instance 1, run: true Nov 29 18:45:27 volumio sudo[15749]: pam_unix(sudo:session): session closed for user root Nov 29 18:45:27 volumio volumio[739]: verbose: New Socket.io Connection to 192.168.1.59 from 192.168.1.48 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Nov 29 18:45:27 volumio volumio[739]: info: camilladsp spawned new process with pid 15760, instance 1, run: true Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::volumioGetVisibleSources Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 29 18:45:27 volumio volumio[739]: info: Received Get System Info Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:27 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:27 volumio volumio[739]: info: Listing playlists Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 29 18:45:27 volumio volumio[739]: info: camilladsp spawned new process with pid 15767, instance 1, run: true Nov 29 18:45:27 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:45:28 volumio volumio[15679]: Traceback (most recent call last): Nov 29 18:45:28 volumio volumio[15679]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:28 volumio volumio[15679]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:28 volumio volumio[15679]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:28 volumio volumio[739]: info: camilladsp spawned new process with pid 15774, instance 1, run: true Nov 29 18:45:28 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:28 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:28 volumio volumio[739]: info: camilladsp spawned new process with pid 15781, instance 1, run: true Nov 29 18:45:28 volumio volumio[739]: info: camilladsp spawned new process with pid 15788, instance 1, run: true Nov 29 18:45:28 volumio volumio[739]: info: camilladsp spawned new process with pid 15795, instance 1, run: true Nov 29 18:45:28 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 29 18:45:28 volumio volumio[739]: info: Received Get System Info Nov 29 18:45:28 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:28 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:28 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:28 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:28 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15802, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15809, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15816, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15823, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 29 18:45:29 volumio volumio[739]: info: Received Get System Info Nov 29 18:45:29 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:29 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:29 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:29 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:29 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15830, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15837, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15844, instance 1, run: true Nov 29 18:45:29 volumio volumio[739]: info: camilladsp spawned new process with pid 15851, instance 1, run: true Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15858, instance 1, run: true Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15865, instance 1, run: true Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15872, instance 1, run: true Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15879, instance 1, run: true Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15886, instance 1, run: true Nov 29 18:45:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 70. Nov 29 18:45:30 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15894, instance 1, run: true Nov 29 18:45:30 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:30 volumio volumio[739]: info: camilladsp spawned new process with pid 15901, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15908, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15915, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15922, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15929, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15936, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15943, instance 1, run: true Nov 29 18:45:31 volumio volumio[739]: info: camilladsp spawned new process with pid 15950, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 15957, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 15965, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 15972, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 15979, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 15986, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 15996, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: camilladsp spawned new process with pid 16003, instance 1, run: true Nov 29 18:45:32 volumio volumio[739]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Nov 29 18:45:33 volumio volumio[739]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Nov 29 18:45:33 volumio volumio[739]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Nov 29 18:45:33 volumio volumio[739]: info: camilladsp spawned new process with pid 16013, instance 1, run: true Nov 29 18:45:33 volumio volumio[739]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Nov 29 18:45:33 volumio volumio[739]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-8bbfr0gu Nov 29 18:45:33 volumio volumio[15893]: Traceback (most recent call last): Nov 29 18:45:33 volumio volumio[15893]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:33 volumio volumio[15893]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:33 volumio volumio[15893]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:33 volumio volumio[739]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-8bbfr0gu Nov 29 18:45:33 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:33 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:33 volumio volumio[739]: info: camilladsp spawned new process with pid 16020, instance 1, run: true Nov 29 18:45:33 volumio volumio[739]: info: camilladsp spawned new process with pid 16027, instance 1, run: true Nov 29 18:45:33 volumio volumio[739]: info: camilladsp spawned new process with pid 16034, instance 1, run: true Nov 29 18:45:34 volumio volumio[739]: info: camilladsp spawned new process with pid 16042, instance 1, run: true Nov 29 18:45:34 volumio volumio[739]: info: camilladsp spawned new process with pid 16049, instance 1, run: true Nov 29 18:45:34 volumio volumio[739]: info: camilladsp spawned new process with pid 16061, instance 1, run: true Nov 29 18:45:34 volumio volumio[739]: info: camilladsp spawned new process with pid 16069, instance 1, run: true Nov 29 18:45:34 volumio volumio[739]: info: camilladsp spawned new process with pid 16079, instance 1, run: true Nov 29 18:45:34 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:45:34 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 29 18:45:34 volumio volumio[739]: info: camilladsp spawned new process with pid 16087, instance 1, run: true Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16109, instance 1, run: true Nov 29 18:45:35 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 29 18:45:35 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 29 18:45:35 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16116, instance 1, run: true Nov 29 18:45:35 volumio volumio[739]: info: Received Get System Version Nov 29 18:45:35 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16123, instance 1, run: true Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16131, instance 1, run: true Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16138, instance 1, run: true Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16145, instance 1, run: true Nov 29 18:45:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 71. Nov 29 18:45:35 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:35 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:35 volumio volumio[739]: info: camilladsp spawned new process with pid 16153, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16160, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16167, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16174, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16181, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16189, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16197, instance 1, run: true Nov 29 18:45:36 volumio volumio[739]: info: camilladsp spawned new process with pid 16204, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16211, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16218, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16225, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16232, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16239, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16246, instance 1, run: true Nov 29 18:45:37 volumio volumio[739]: info: camilladsp spawned new process with pid 16253, instance 1, run: true Nov 29 18:45:38 volumio volumio[739]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Nov 29 18:45:38 volumio volumio[739]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Nov 29 18:45:38 volumio volumio[739]: info: camilladsp spawned new process with pid 16261, instance 1, run: true Nov 29 18:45:38 volumio volumio[739]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Nov 29 18:45:38 volumio volumio[739]: info: Collecting jsonschema (from camilladsp-plot==1.0.2) Nov 29 18:45:38 volumio volumio[16152]: Traceback (most recent call last): Nov 29 18:45:38 volumio volumio[16152]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:38 volumio volumio[16152]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:38 volumio volumio[16152]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:38 volumio volumio[739]: info: camilladsp spawned new process with pid 16268, instance 1, run: true Nov 29 18:45:38 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:38 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16275, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16283, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16290, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16297, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16304, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16311, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16318, instance 1, run: true Nov 29 18:45:39 volumio volumio[739]: info: camilladsp spawned new process with pid 16325, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16332, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16339, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16346, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16353, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16360, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16367, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16374, instance 1, run: true Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16381, instance 1, run: true Nov 29 18:45:40 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:40 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 72. Nov 29 18:45:40 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:40 volumio volumio[739]: info: camilladsp spawned new process with pid 16389, instance 1, run: true Nov 29 18:45:40 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16396, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16403, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16410, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16417, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16424, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16431, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: camilladsp spawned new process with pid 16438, instance 1, run: true Nov 29 18:45:41 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Nov 29 18:45:41 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/c1/97/c698bd9350f307daad79dd740806e1a59becd693bd11443a0f531e3229b3/jsonschema-4.17.3-py3-none-any.whl (90kB) Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16445, instance 1, run: true Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16452, instance 1, run: true Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16459, instance 1, run: true Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16466, instance 1, run: true Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16473, instance 1, run: true Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16480, instance 1, run: true Nov 29 18:45:42 volumio volumio[739]: info: camilladsp spawned new process with pid 16487, instance 1, run: true Nov 29 18:45:43 volumio volumio[739]: info: camilladsp spawned new process with pid 16494, instance 1, run: true Nov 29 18:45:43 volumio volumio[739]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:43 volumio volumio[739]: info: Collecting typing-extensions; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:43 volumio volumio[739]: info: camilladsp spawned new process with pid 16501, instance 1, run: true Nov 29 18:45:43 volumio volumio[739]: info: camilladsp spawned new process with pid 16508, instance 1, run: true Nov 29 18:45:43 volumio volumio[739]: info: camilladsp spawned new process with pid 16515, instance 1, run: true Nov 29 18:45:43 volumio volumio[739]: info: camilladsp spawned new process with pid 16522, instance 1, run: true Nov 29 18:45:43 volumio volumio[16388]: Traceback (most recent call last): Nov 29 18:45:43 volumio volumio[16388]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:43 volumio volumio[16388]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:43 volumio volumio[16388]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:43 volumio volumio[739]: info: camilladsp spawned new process with pid 16529, instance 1, run: true Nov 29 18:45:44 volumio volumio[739]: info: camilladsp spawned new process with pid 16536, instance 1, run: true Nov 29 18:45:44 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:44 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:44 volumio volumio[739]: info: camilladsp spawned new process with pid 16543, instance 1, run: true Nov 29 18:45:44 volumio volumio[739]: info: camilladsp spawned new process with pid 16550, instance 1, run: true Nov 29 18:45:44 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Nov 29 18:45:44 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/ec/6b/63cc3df74987c36fe26157ee12e09e8f9db4de771e0f3404263117e75b95/typing_extensions-4.7.1-py3-none-any.whl Nov 29 18:45:44 volumio volumio[739]: info: camilladsp spawned new process with pid 16557, instance 1, run: true Nov 29 18:45:44 volumio volumio[739]: info: camilladsp spawned new process with pid 16564, instance 1, run: true Nov 29 18:45:44 volumio volumio[739]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:44 volumio volumio[739]: info: Collecting importlib-resources>=1.4.0; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:44 volumio volumio[739]: info: camilladsp spawned new process with pid 16571, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 29 18:45:45 volumio volumio[739]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 29 18:45:45 volumio volumio[739]: info: Received Get System Version Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 29 18:45:45 volumio volumio[739]: info: Received Get System Info Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:45 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:45 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16578, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16585, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16592, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16599, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16606, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16613, instance 1, run: true Nov 29 18:45:45 volumio volumio[739]: info: camilladsp spawned new process with pid 16620, instance 1, run: true Nov 29 18:45:46 volumio volumio[739]: info: camilladsp spawned new process with pid 16627, instance 1, run: true Nov 29 18:45:46 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:46 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 73. Nov 29 18:45:46 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:46 volumio volumio[739]: info: camilladsp spawned new process with pid 16635, instance 1, run: true Nov 29 18:45:46 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:46 volumio volumio[739]: info: camilladsp spawned new process with pid 16642, instance 1, run: true Nov 29 18:45:46 volumio volumio[739]: info: camilladsp spawned new process with pid 16649, instance 1, run: true Nov 29 18:45:46 volumio volumio[739]: info: camilladsp spawned new process with pid 16656, instance 1, run: true Nov 29 18:45:46 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Nov 29 18:45:46 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/38/71/c13ea695a4393639830bf96baea956538ba7a9d06fcce7cef10bfff20f72/importlib_resources-5.12.0-py3-none-any.whl Nov 29 18:45:46 volumio volumio[739]: info: camilladsp spawned new process with pid 16663, instance 1, run: true Nov 29 18:45:47 volumio volumio[739]: info: camilladsp spawned new process with pid 16670, instance 1, run: true Nov 29 18:45:47 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:47 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:47 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:47 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:47 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:47 volumio volumio[739]: info: camilladsp spawned new process with pid 16677, instance 1, run: true Nov 29 18:45:47 volumio volumio[739]: info: camilladsp spawned new process with pid 16684, instance 1, run: true Nov 29 18:45:47 volumio volumio[739]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:47 volumio volumio[739]: info: Collecting importlib-metadata; python_version < "3.8" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:47 volumio volumio[739]: info: camilladsp spawned new process with pid 16691, instance 1, run: true Nov 29 18:45:47 volumio volumio[739]: info: camilladsp spawned new process with pid 16698, instance 1, run: true Nov 29 18:45:48 volumio volumio[739]: info: camilladsp spawned new process with pid 16705, instance 1, run: true Nov 29 18:45:48 volumio volumio[739]: info: camilladsp spawned new process with pid 16712, instance 1, run: true Nov 29 18:45:48 volumio volumio[739]: info: camilladsp spawned new process with pid 16719, instance 1, run: true Nov 29 18:45:48 volumio volumio[739]: info: camilladsp spawned new process with pid 16726, instance 1, run: true Nov 29 18:45:48 volumio volumio[739]: info: camilladsp spawned new process with pid 16733, instance 1, run: true Nov 29 18:45:48 volumio volumio[16634]: Traceback (most recent call last): Nov 29 18:45:48 volumio volumio[16634]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:48 volumio volumio[16634]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:48 volumio volumio[16634]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:48 volumio volumio[739]: info: camilladsp spawned new process with pid 16740, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16747, instance 1, run: true Nov 29 18:45:49 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:49 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16754, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16761, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16768, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16775, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16782, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16789, instance 1, run: true Nov 29 18:45:49 volumio volumio[739]: info: camilladsp spawned new process with pid 16796, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16803, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16810, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16817, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16824, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16831, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16838, instance 1, run: true Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16845, instance 1, run: true Nov 29 18:45:50 volumio go-librespot[967]: time="2024-11-29T18:45:50+01:00" level=trace msg="emitting websocket event: not_playing" Nov 29 18:45:50 volumio go-librespot[967]: time="2024-11-29T18:45:50+01:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:50 volumio volumio[739]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:3cxAKEcgwYYLVUiKslkzSw","play_origin":"album"}} Nov 29 18:45:50 volumio volumio[739]: error: Failed to decode event: not_playing Nov 29 18:45:50 volumio volumio[739]: info: camilladsp spawned new process with pid 16852, instance 1, run: true Nov 29 18:45:50 volumio go-librespot[967]: time="2024-11-29T18:45:50+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 29 18:45:50 volumio go-librespot[967]: time="2024-11-29T18:45:50+01:00" level=trace msg="emitting websocket event: will_play" Nov 29 18:45:50 volumio volumio[739]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:0RyyGvF8j3pDpXPVrHhAda","play_origin":"album"}} Nov 29 18:45:50 volumio go-librespot[967]: time="2024-11-29T18:45:50+01:00" level=info msg="loaded track \"This Fire of Autumn\" (paused: false, position: 0ms, duration: 257253ms, prefetched: true)" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:45:51 volumio go-librespot[967]: time="2024-11-29T18:45:51+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 29 18:45:51 volumio go-librespot[967]: time="2024-11-29T18:45:51+01:00" level=trace msg="scheduling prefetch in 227s" Nov 29 18:45:51 volumio go-librespot[967]: time="2024-11-29T18:45:51+01:00" level=trace msg="emitting websocket event: metadata" Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16859, instance 1, run: true Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0RyyGvF8j3pDpXPVrHhAda","name":"This Fire of Autumn","artist_names":["Tindersticks"],"album_name":"The Something Rain","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02a17bc049caa9a8ea497d3bb2","position":0,"duration":257253,"release_date":"year:2012 month:2 day:17","track_number":3,"disc_number":1}} Nov 29 18:45:51 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:51 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 74. Nov 29 18:45:51 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:51 volumio go-librespot[967]: time="2024-11-29T18:45:51+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 29 18:45:51 volumio go-librespot[967]: time="2024-11-29T18:45:51+01:00" level=trace msg="emitting websocket event: playing" Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0RyyGvF8j3pDpXPVrHhAda","play_origin":"album"}} Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: PUSH STATE SPOTIFY Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: {"status":"play","service":"spop","title":"This Fire of Autumn","artist":"Tindersticks","album":"The Something Rain","albumart":"https://i.scdn.co/image/ab67616d00001e02a17bc049caa9a8ea497d3bb2","uri":"spotify:track:0RyyGvF8j3pDpXPVrHhAda","trackType":"spotify","seek":1000,"duration":257,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Nov 29 18:45:51 volumio volumio[739]: info: CoreCommandRouter::servicePushState Nov 29 18:45:51 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:51 volumio volumio[739]: info: CoreStateMachine::pushState Nov 29 18:45:51 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 18:45:51 volumio volumio[739]: info: CoreCommandRouter::volumioPushState Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16867, instance 1, run: true Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16874, instance 1, run: true Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: PUSH STATE SPOTIFY Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: {"status":"play","service":"spop","title":"This Fire of Autumn","artist":"Tindersticks","album":"The Something Rain","albumart":"https://i.scdn.co/image/ab67616d00001e02a17bc049caa9a8ea497d3bb2","uri":"spotify:track:0RyyGvF8j3pDpXPVrHhAda","trackType":"spotify","seek":1000,"duration":257,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Nov 29 18:45:51 volumio volumio[739]: info: CoreCommandRouter::servicePushState Nov 29 18:45:51 volumio volumio[739]: info: CoreStateMachine::pushState Nov 29 18:45:51 volumio volumio[739]: info: CoreCommandRouter::volumioPushState Nov 29 18:45:51 volumio volumio[739]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16881, instance 1, run: true Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16888, instance 1, run: true Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16895, instance 1, run: true Nov 29 18:45:51 volumio volumio[739]: info: camilladsp spawned new process with pid 16902, instance 1, run: true Nov 29 18:45:52 volumio volumio[739]: info: camilladsp spawned new process with pid 16909, instance 1, run: true Nov 29 18:45:52 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Nov 29 18:45:52 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/ff/94/64287b38c7de4c90683630338cf28f129decbba0a44f0c6db35a873c73c4/importlib_metadata-6.7.0-py3-none-any.whl Nov 29 18:45:52 volumio volumio[739]: info: camilladsp spawned new process with pid 16916, instance 1, run: true Nov 29 18:45:52 volumio volumio[739]: info: camilladsp spawned new process with pid 16923, instance 1, run: true Nov 29 18:45:52 volumio volumio[739]: info: camilladsp spawned new process with pid 16930, instance 1, run: true Nov 29 18:45:52 volumio volumio[739]: info: camilladsp spawned new process with pid 16937, instance 1, run: true Nov 29 18:45:52 volumio volumio[739]: info: camilladsp spawned new process with pid 16944, instance 1, run: true Nov 29 18:45:53 volumio volumio[739]: info: camilladsp spawned new process with pid 16951, instance 1, run: true Nov 29 18:45:53 volumio volumio[739]: info: camilladsp spawned new process with pid 16958, instance 1, run: true Nov 29 18:45:53 volumio volumio[739]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Nov 29 18:45:53 volumio volumio[739]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Nov 29 18:45:53 volumio volumio[739]: info: camilladsp spawned new process with pid 16965, instance 1, run: true Nov 29 18:45:53 volumio volumio[739]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:53 volumio volumio[739]: info: Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:53 volumio volumio[16866]: Traceback (most recent call last): Nov 29 18:45:53 volumio volumio[16866]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:53 volumio volumio[16866]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:53 volumio volumio[16866]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:53 volumio volumio[739]: info: camilladsp spawned new process with pid 16972, instance 1, run: true Nov 29 18:45:53 volumio volumio[739]: verbose: New Socket.io Connection to 192.168.1.59 from 192.168.1.48 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::volumioGetVisibleSources Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 29 18:45:53 volumio volumio[739]: info: Received Get System Info Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:45:53 volumio volumio[739]: info: Discovery: Getting this device information Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:45:53 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Nov 29 18:45:54 volumio volumio[739]: info: Listing playlists Nov 29 18:45:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:54 volumio volumio[739]: info: camilladsp spawned new process with pid 16979, instance 1, run: true Nov 29 18:45:54 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 29 18:45:54 volumio volumio[739]: info: camilladsp spawned new process with pid 16986, instance 1, run: true Nov 29 18:45:54 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:45:54 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:45:55 volumio volumio[739]: info: camilladsp spawned new process with pid 16994, instance 1, run: true Nov 29 18:45:55 volumio volumio[739]: info: camilladsp spawned new process with pid 17001, instance 1, run: true Nov 29 18:45:56 volumio volumio[739]: info: camilladsp spawned new process with pid 17008, instance 1, run: true Nov 29 18:45:56 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:45:56 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 75. Nov 29 18:45:56 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:45:56 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:45:56 volumio volumio[739]: info: camilladsp spawned new process with pid 17016, instance 1, run: true Nov 29 18:45:56 volumio volumio[739]: info: camilladsp spawned new process with pid 17023, instance 1, run: true Nov 29 18:45:56 volumio volumio[739]: info: camilladsp spawned new process with pid 17030, instance 1, run: true Nov 29 18:45:56 volumio volumio[739]: info: camilladsp spawned new process with pid 17037, instance 1, run: true Nov 29 18:45:56 volumio volumio[739]: info: camilladsp spawned new process with pid 17044, instance 1, run: true Nov 29 18:45:57 volumio volumio[739]: info: camilladsp spawned new process with pid 17051, instance 1, run: true Nov 29 18:45:57 volumio volumio[739]: info: camilladsp spawned new process with pid 17058, instance 1, run: true Nov 29 18:45:57 volumio volumio[739]: info: camilladsp spawned new process with pid 17065, instance 1, run: true Nov 29 18:45:57 volumio volumio[739]: info: camilladsp spawned new process with pid 17072, instance 1, run: true Nov 29 18:45:57 volumio volumio[739]: info: camilladsp spawned new process with pid 17079, instance 1, run: true Nov 29 18:45:57 volumio volumio[739]: info: camilladsp spawned new process with pid 17086, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17093, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17100, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Nov 29 18:45:58 volumio volumio[739]: info: Downloading https://www.piwheels.org/simple/pyrsistent/pyrsistent-0.19.3-cp37-cp37m-linux_armv7l.whl (83kB) Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17107, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17114, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17121, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17128, instance 1, run: true Nov 29 18:45:58 volumio volumio[739]: info: camilladsp spawned new process with pid 17135, instance 1, run: true Nov 29 18:45:58 volumio volumio[17015]: Traceback (most recent call last): Nov 29 18:45:58 volumio volumio[17015]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:45:58 volumio volumio[17015]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:45:58 volumio volumio[17015]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:45:59 volumio volumio[739]: info: camilladsp spawned new process with pid 17142, instance 1, run: true Nov 29 18:45:59 volumio volumio[739]: info: camilladsp spawned new process with pid 17149, instance 1, run: true Nov 29 18:45:59 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:45:59 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:45:59 volumio volumio[739]: info: camilladsp spawned new process with pid 17156, instance 1, run: true Nov 29 18:45:59 volumio volumio[739]: info: camilladsp spawned new process with pid 17163, instance 1, run: true Nov 29 18:45:59 volumio volumio[739]: info: camilladsp spawned new process with pid 17170, instance 1, run: true Nov 29 18:45:59 volumio volumio[739]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:59 volumio volumio[739]: info: Collecting pkgutil-resolve-name>=1.3.10; python_version < "3.9" (from jsonschema->camilladsp-plot==1.0.2) Nov 29 18:45:59 volumio volumio[739]: info: camilladsp spawned new process with pid 17177, instance 1, run: true Nov 29 18:45:59 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Nov 29 18:45:59 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/c9/5c/3d4882ba113fd55bdba9326c1e4c62a15e674a2501de4869e6bd6301f87e/pkgutil_resolve_name-1.3.10-py3-none-any.whl Nov 29 18:46:00 volumio volumio[739]: info: camilladsp spawned new process with pid 17184, instance 1, run: true Nov 29 18:46:00 volumio volumio[739]: info: camilladsp spawned new process with pid 17191, instance 1, run: true Nov 29 18:46:00 volumio volumio[739]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Nov 29 18:46:00 volumio volumio[739]: info: Collecting zipp>=3.1.0; python_version < "3.10" (from importlib-resources>=1.4.0; python_version < "3.9"->jsonschema->camilladsp-plot==1.0.2) Nov 29 18:46:00 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 29 18:46:00 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 29 18:46:00 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:46:00 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:46:00 volumio volumio[739]: info: camilladsp spawned new process with pid 17198, instance 1, run: true Nov 29 18:46:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:46:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 76. Nov 29 18:46:01 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:46:01 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:46:01 volumio volumio[739]: info: camilladsp spawned new process with pid 17206, instance 1, run: true Nov 29 18:46:01 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Nov 29 18:46:01 volumio volumio[739]: info: Downloading https://files.pythonhosted.org/packages/5b/fa/c9e82bbe1af6266adf08afb563905eb87cab83fde00a0a08963510621047/zipp-3.15.0-py3-none-any.whl Nov 29 18:46:02 volumio volumio[739]: info: camilladsp spawned new process with pid 17213, instance 1, run: true Nov 29 18:46:02 volumio volumio[739]: info: camilladsp spawned new process with pid 17220, instance 1, run: true Nov 29 18:46:02 volumio volumio[739]: info: Building wheels for collected packages: camilladsp-plot Nov 29 18:46:02 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp-plot: started Nov 29 18:46:02 volumio volumio[739]: info: Building wheels for collected packages: camilladsp-plot Nov 29 18:46:02 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp-plot: started Nov 29 18:46:02 volumio volumio[739]: info: camilladsp spawned new process with pid 17228, instance 1, run: true Nov 29 18:46:02 volumio volumio[739]: info: camilladsp spawned new process with pid 17235, instance 1, run: true Nov 29 18:46:03 volumio volumio[739]: info: camilladsp spawned new process with pid 17242, instance 1, run: true Nov 29 18:46:03 volumio volumio[739]: info: camilladsp spawned new process with pid 17249, instance 1, run: true Nov 29 18:46:03 volumio volumio[739]: info: camilladsp spawned new process with pid 17256, instance 1, run: true Nov 29 18:46:03 volumio volumio[739]: info: camilladsp spawned new process with pid 17263, instance 1, run: true Nov 29 18:46:03 volumio volumio[739]: info: camilladsp spawned new process with pid 17270, instance 1, run: true Nov 29 18:46:03 volumio go-librespot[967]: time="2024-11-29T18:46:03+01:00" level=debug msg="fetched chunk 4/20, size: 524288" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:46:03 volumio volumio[739]: info: camilladsp spawned new process with pid 17277, instance 1, run: true Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17284, instance 1, run: true Nov 29 18:46:04 volumio volumio[17205]: Traceback (most recent call last): Nov 29 18:46:04 volumio volumio[17205]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:46:04 volumio volumio[17205]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:46:04 volumio volumio[17205]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17291, instance 1, run: true Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17300, instance 1, run: true Nov 29 18:46:04 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:46:04 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17307, instance 1, run: true Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17314, instance 1, run: true Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17321, instance 1, run: true Nov 29 18:46:04 volumio volumio[739]: info: camilladsp spawned new process with pid 17328, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17335, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17342, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17349, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17356, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17363, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17370, instance 1, run: true Nov 29 18:46:05 volumio volumio[739]: info: camilladsp spawned new process with pid 17377, instance 1, run: true Nov 29 18:46:06 volumio volumio[739]: info: camilladsp spawned new process with pid 17384, instance 1, run: true Nov 29 18:46:06 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Nov 29 18:46:06 volumio volumio[739]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Nov 29 18:46:06 volumio volumio[739]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-tfs7t_8s/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Nov 29 18:46:06 volumio volumio[739]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:46:06 volumio volumio[739]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-tfs7t_8s/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Nov 29 18:46:06 volumio volumio[739]: info: camilladsp spawned new process with pid 17391, instance 1, run: true Nov 29 18:46:06 volumio volumio[739]: info: Successfully built camilladsp-plot Nov 29 18:46:06 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:46:06 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 77. Nov 29 18:46:06 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:46:06 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:46:06 volumio volumio[739]: info: Successfully built camilladsp-plot Nov 29 18:46:07 volumio volumio[739]: info: camilladsp spawned new process with pid 17399, instance 1, run: true Nov 29 18:46:07 volumio volumio[739]: info: camilladsp spawned new process with pid 17406, instance 1, run: true Nov 29 18:46:08 volumio volumio[739]: info: camilladsp spawned new process with pid 17413, instance 1, run: true Nov 29 18:46:08 volumio volumio[739]: info: camilladsp spawned new process with pid 17420, instance 1, run: true Nov 29 18:46:08 volumio volumio[739]: info: camilladsp spawned new process with pid 17427, instance 1, run: true Nov 29 18:46:08 volumio volumio[739]: info: camilladsp spawned new process with pid 17434, instance 1, run: true Nov 29 18:46:08 volumio volumio[739]: info: Installing collected packages: typing-extensions, zipp, importlib-resources, importlib-metadata, pyrsistent, pkgutil-resolve-name, jsonschema, camilladsp-plot Nov 29 18:46:08 volumio volumio[739]: info: Installing collected packages: typing-extensions, zipp, importlib-resources, importlib-metadata, pyrsistent, pkgutil-resolve-name, jsonschema, camilladsp-plot Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17441, instance 1, run: true Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17448, instance 1, run: true Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17455, instance 1, run: true Nov 29 18:46:09 volumio volumio[17398]: Traceback (most recent call last): Nov 29 18:46:09 volumio volumio[17398]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Nov 29 18:46:09 volumio volumio[17398]: from camilladsp_plot.validate_config import CamillaValidator Nov 29 18:46:09 volumio volumio[17398]: ModuleNotFoundError: No module named 'camilladsp_plot' Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17462, instance 1, run: true Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17469, instance 1, run: true Nov 29 18:46:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Nov 29 18:46:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17476, instance 1, run: true Nov 29 18:46:09 volumio volumio[739]: info: camilladsp spawned new process with pid 17483, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17490, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17497, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17504, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17511, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17518, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17525, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17532, instance 1, run: true Nov 29 18:46:10 volumio volumio[739]: info: camilladsp spawned new process with pid 17539, instance 1, run: true Nov 29 18:46:11 volumio volumio[739]: info: camilladsp spawned new process with pid 17546, instance 1, run: true Nov 29 18:46:11 volumio volumio[739]: info: camilladsp spawned new process with pid 17553, instance 1, run: true Nov 29 18:46:11 volumio volumio[739]: info: camilladsp spawned new process with pid 17560, instance 1, run: true Nov 29 18:46:11 volumio volumio[739]: info: camilladsp spawned new process with pid 17567, instance 1, run: true Nov 29 18:46:11 volumio volumio[739]: info: camilladsp spawned new process with pid 17574, instance 1, run: true Nov 29 18:46:11 volumio volumio[739]: info: Successfully installed camilladsp-plot-1.0.2 importlib-metadata-6.7.0 importlib-resources-5.12.0 jsonschema-4.17.3 pkgutil-resolve-name-1.3.10 pyrsistent-0.19.3 typing-extensions-4.7.1 zipp-3.15.0 Nov 29 18:46:11 volumio volumio[739]: info: Successfully installed camilladsp-plot-1.0.2 importlib-metadata-6.7.0 importlib-resources-5.12.0 jsonschema-4.17.3 pkgutil-resolve-name-1.3.10 pyrsistent-0.19.3 typing-extensions-4.7.1 zipp-3.15.0 Nov 29 18:46:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Nov 29 18:46:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 78. Nov 29 18:46:11 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 29 18:46:11 volumio volumio[739]: info: camilladsp spawned new process with pid 17581, instance 1, run: true Nov 29 18:46:11 volumio systemd[1]: Started FusionDsp Daemon. Nov 29 18:46:12 volumio volumio[739]: info: camilladsp spawned new process with pid 17589, instance 1, run: true Nov 29 18:46:12 volumio volumio[739]: info: camilladsp spawned new process with pid 17596, instance 1, run: true Nov 29 18:46:12 volumio volumio[739]: info: copying hw detection script Nov 29 18:46:12 volumio volumio[739]: info: copying hw detection script Nov 29 18:46:12 volumio volumio[739]: info: camilladsp spawned new process with pid 17607, instance 1, run: true Nov 29 18:46:12 volumio volumio[739]: info: Detected cpu architecture as armv7l Nov 29 18:46:12 volumio volumio[739]: info: Detected cpu architecture as armv7l Nov 29 18:46:12 volumio volumio[739]: info: camilladsp spawned new process with pid 17614, instance 1, run: true Nov 29 18:46:12 volumio volumio[739]: info: camilladsp spawned new process with pid 17621, instance 1, run: true Nov 29 18:46:13 volumio volumio[739]: info: camilladsp spawned new process with pid 17628, instance 1, run: true Nov 29 18:46:13 volumio volumio[739]: info: camilladsp spawned new process with pid 17635, instance 1, run: true Nov 29 18:46:13 volumio volumio[739]: info: camilladsp spawned new process with pid 17642, instance 1, run: true Nov 29 18:46:13 volumio volumio[739]: info: camilladsp spawned new process with pid 17649, instance 1, run: true Nov 29 18:46:13 volumio volumio[739]: info: camilladsp spawned new process with pid 17656, instance 1, run: true Nov 29 18:46:14 volumio volumio[739]: info: camilladsp spawned new process with pid 17665, instance 1, run: true Nov 29 18:46:14 volumio volumio[739]: info: camilladsp Nov 29 18:46:14 volumio volumio[739]: info: camilladsp Nov 29 18:46:14 volumio volumio[739]: info: camilladsp spawned new process with pid 17672, instance 1, run: true Nov 29 18:46:14 volumio volumio[739]: info: camilladsp spawned new process with pid 17679, instance 1, run: true Nov 29 18:46:14 volumio volumio[739]: info: camilladsp spawned new process with pid 17687, instance 1, run: true Nov 29 18:46:14 volumio volumio[739]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 29 18:46:14 volumio volumio[739]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 18:46:14 volumio volumio[739]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES Nov 29 18:46:14 volumio volumio[739]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 29 18:46:14 volumio volumio[739]: at onErrorNT (internal/child_process.js:465:16) Nov 29 18:46:14 volumio volumio[739]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 29 18:46:14 volumio volumio[739]: errno: -13, Nov 29 18:46:14 volumio volumio[739]: code: 'EACCES', Nov 29 18:46:14 volumio volumio[739]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 29 18:46:14 volumio volumio[739]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 29 18:46:14 volumio volumio[739]: spawnargs: [ Nov 29 18:46:14 volumio volumio[739]: '-p', Nov 29 18:46:14 volumio volumio[739]: 9876, Nov 29 18:46:14 volumio volumio[739]: '-o', Nov 29 18:46:14 volumio volumio[739]: '/tmp/camilladsp.log', Nov 29 18:46:14 volumio volumio[739]: '-l', Nov 29 18:46:14 volumio volumio[739]: 'warn', Nov 29 18:46:14 volumio volumio[739]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 29 18:46:14 volumio volumio[739]: ] Nov 29 18:46:14 volumio volumio[739]: } Nov 29 18:46:14 volumio volumio[739]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 18:46:14 volumio sudo[17699]: 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 Nov 29 18:46:14 volumio sudo[17699]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:46:14 volumio sudo[17699]: pam_unix(sudo:session): session closed for user root Nov 29 18:46:15 volumio sudo[17703]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Nov 29 18:46:15 volumio sudo[17703]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:46:15 volumio sudo[17703]: pam_unix(sudo:session): session closed for user root Nov 29 18:46:15 volumio sudo[17710]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Nov 29 18:46:15 volumio sudo[17710]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 18:46:16 volumio go-librespot[967]: time="2024-11-29T18:46:16+01:00" level=debug msg="fetched chunk 5/20, size: 524288" uri="spotify:track:0RyyGvF8j3pDpXPVrHhAda" Nov 29 18:46:16 volumio sudo[17716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 18:45 Nov 29 18:46:16 volumio sudo[17716]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"