-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Sat 2025-03-08 09:51:43 GMT. -- Mar 08 09:50:00 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:00 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 334. Mar 08 09:50:00 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:00 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:00 volumio volumio[3975]: Traceback (most recent call last): Mar 08 09:50:00 volumio volumio[3975]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:00 volumio volumio[3975]: from aiohttp import web Mar 08 09:50:00 volumio volumio[3975]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:01 volumio volumio[987]: info: Mar 08 09:50:01 volumio volumio[987]: ---------------------------- MPD announces system playlist update Mar 08 09:50:01 volumio volumio[987]: info: Ignoring MPD Status Update Mar 08 09:50:01 volumio volumio[987]: info: Mar 08 09:50:01 volumio volumio[987]: ---------------------------- MPD announces state update: player Mar 08 09:50:01 volumio volumio[987]: info: ControllerMpd::getState Mar 08 09:50:01 volumio volumio[987]: verbose: ControllerMpd::sendMpdCommand status Mar 08 09:50:01 volumio volumio[987]: info: ------------------------------ 2ms Mar 08 09:50:01 volumio volumio[987]: info: sendMpdCommand status took 2 milliseconds Mar 08 09:50:01 volumio volumio[987]: verbose: ControllerMpd::parseState Mar 08 09:50:01 volumio volumio[987]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 09:50:01 volumio volumio[987]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 09:50:01 volumio volumio[987]: verbose: ControllerMpd::parseTrackInfo Mar 08 09:50:01 volumio volumio[987]: info: ControllerMpd::pushState Mar 08 09:50:01 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:50:01 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:50:01 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:50:01 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:50:01 volumio volumio[987]: info: ------------------------------ 13ms Mar 08 09:50:01 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:50:01 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:01 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:01 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:50:01 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:50:02 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:02 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 335. Mar 08 09:50:02 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:02 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:02 volumio volumio[3977]: Traceback (most recent call last): Mar 08 09:50:02 volumio volumio[3977]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:02 volumio volumio[3977]: from aiohttp import web Mar 08 09:50:02 volumio volumio[3977]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:02 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:02 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 336. Mar 08 09:50:05 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:05 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:05 volumio volumio[4023]: Traceback (most recent call last): Mar 08 09:50:05 volumio volumio[4023]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:05 volumio volumio[4023]: from aiohttp import web Mar 08 09:50:05 volumio volumio[4023]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:07 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:07 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 337. Mar 08 09:50:07 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:07 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:07 volumio volumio[4024]: Traceback (most recent call last): Mar 08 09:50:07 volumio volumio[4024]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:07 volumio volumio[4024]: from aiohttp import web Mar 08 09:50:07 volumio volumio[4024]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 338. Mar 08 09:50:09 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:09 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:09 volumio volumio[4039]: Traceback (most recent call last): Mar 08 09:50:09 volumio volumio[4039]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:09 volumio volumio[4039]: from aiohttp import web Mar 08 09:50:09 volumio volumio[4039]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 339. Mar 08 09:50:11 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:11 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:11 volumio volumio[4043]: Traceback (most recent call last): Mar 08 09:50:11 volumio volumio[4043]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:11 volumio volumio[4043]: from aiohttp import web Mar 08 09:50:11 volumio volumio[4043]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:11 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:11 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 340. Mar 08 09:50:14 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:14 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:14 volumio volumio[4045]: Traceback (most recent call last): Mar 08 09:50:14 volumio volumio[4045]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:14 volumio volumio[4045]: from aiohttp import web Mar 08 09:50:14 volumio volumio[4045]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 341. Mar 08 09:50:16 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:16 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:16 volumio volumio[4046]: Traceback (most recent call last): Mar 08 09:50:16 volumio volumio[4046]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:16 volumio volumio[4046]: from aiohttp import web Mar 08 09:50:16 volumio volumio[4046]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 342. Mar 08 09:50:18 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:18 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:18 volumio volumio[4047]: Traceback (most recent call last): Mar 08 09:50:18 volumio volumio[4047]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:18 volumio volumio[4047]: from aiohttp import web Mar 08 09:50:18 volumio volumio[4047]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 343. Mar 08 09:50:20 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:20 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:20 volumio volumio[4062]: Traceback (most recent call last): Mar 08 09:50:20 volumio volumio[4062]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:20 volumio volumio[4062]: from aiohttp import web Mar 08 09:50:20 volumio volumio[4062]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:20 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:20 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 344. Mar 08 09:50:23 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:23 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:23 volumio volumio[4063]: Traceback (most recent call last): Mar 08 09:50:23 volumio volumio[4063]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:23 volumio volumio[4063]: from aiohttp import web Mar 08 09:50:23 volumio volumio[4063]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 345. Mar 08 09:50:25 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:25 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:25 volumio volumio[4064]: Traceback (most recent call last): Mar 08 09:50:25 volumio volumio[4064]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:25 volumio volumio[4064]: from aiohttp import web Mar 08 09:50:25 volumio volumio[4064]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:26 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Mar 08 09:50:26 volumio volumio[987]: info: In handleBrowseUri, curUri=spotify/myrecentlyplayedtracks Mar 08 09:50:27 volumio volumio[987]: info: Preload queue cleared Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6GqRnLm8b3RLHOmDinAbYt Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1PtJclc46wTk367PlsU6Uj Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5Ihd9HrPvOADyVoonH9ZjB Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:51uTbPmQnApLyfnfn0bpC7 Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:0X67jDdNTccPE8LCm8fT6r Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5vDMbf8GHZhbyqxBLy5PKp Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6yg5A6yiu5kDN9Kiil7iUr Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5Fy40smNxk0j5OpFMtvfaU Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:0YC3WfFZkZBpUeaHt4Eggk Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6mcmKco5obfTkhNsCghgeq Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:77CA8SLEVa62gmW0s7Td4A Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1fUKZpXy4XfxCLEFE7WaW9 Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6MCoVicJXlNSLh5lETQJxe Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1mMYaXpT65iZDtvfRA9EkE Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:3sPKULZYV344Xn6yx8I1rH Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6GS6uE1vDmtzxO8GztAR2O Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6fh2SXy67ei7fzpXMIktY7 Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:0u2CGItUO2jYEiFaXD7n5S Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:7py16W5fWYLFFS6BElKAjn Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:0yNCFwihschpOwSgK31f2O Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:3SmPl0CGxvvkQCrTv7edEE Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6nXzKd8oA6N1qgG1vMZUKe Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4IYKjN1DrYzxKXt0umJqsG Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6HF0YzbYubg86ucne1NdaF Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:2cG8UHHDmVEa7H1U1cG96I Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5c33j1xFVOL4G24zxYhssB Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:3D6xxbFiyPRduSUowHbjSP Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:2H2gRsnrQ9AAhyyxdoLk7U Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1ur5N3DQS8JX686I0xmRhs Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6LiK3fDottplOUsLHfhXto Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4PyhlL1vrSvPlhYLdphszr Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:4zl7r00yVvYPS8gZriSS6X Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6Afrv2uPWjlKJvMPlpsBxP Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:01JRVFY79m7784ArNpd41F Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:742hY2twqAjwNYnKkQdilj Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5eFCFpmDbqGqpdOVE9CXCh Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:27 volumio volumio[987]: info: Preloading song: spotify:track:6JrAEmBFd61eYIGVOSPnT4 Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:4WuxxGa7qAMBpNFFyHsLlE in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:4WuxxGa7qAMBpNFFyHsLlE in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:4WuxxGa7qAMBpNFFyHsLlE in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","service":"spop","name":"ANGUKA NAYO","artist":"From The Hood Music","album":"ANGUKA NAYO","type":"song","duration":195,"albumart":"https://i.scdn.co/image/ab67616d0000b273d1f37caf37639cd88c47a3b7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Using cached record of: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","service":"spop","name":"ANGUKA NAYO","artist":"From The Hood Music","album":"ANGUKA NAYO","type":"song","duration":195,"albumart":"https://i.scdn.co/image/ab67616d0000b273d1f37caf37639cd88c47a3b7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:6GqRnLm8b3RLHOmDinAbYt in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6GqRnLm8b3RLHOmDinAbYt Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","service":"spop","name":"ANGUKA NAYO","artist":"From The Hood Music","album":"ANGUKA NAYO","type":"song","duration":195,"albumart":"https://i.scdn.co/image/ab67616d0000b273d1f37caf37639cd88c47a3b7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:1PtJclc46wTk367PlsU6Uj in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1PtJclc46wTk367PlsU6Uj Mar 08 09:50:27 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6GqRnLm8b3RLHOmDinAbYt","service":"spop","name":"You Know How to Love Me - Edit","artist":"Phyllis Hyman","album":"The Essential Phyllis Hyman","type":"song","duration":228,"albumart":"https://i.scdn.co/image/ab67616d0000b2736b826d6a3146006702cfba5e","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 346. Mar 08 09:50:27 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:5Ihd9HrPvOADyVoonH9ZjB in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5Ihd9HrPvOADyVoonH9ZjB Mar 08 09:50:27 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:51uTbPmQnApLyfnfn0bpC7 in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:51uTbPmQnApLyfnfn0bpC7 Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1PtJclc46wTk367PlsU6Uj","service":"spop","name":"I Have A Dream","artist":"ABBA","album":"Voulez-Vous","type":"song","duration":285,"albumart":"https://i.scdn.co/image/ab67616d0000b273aa22899360d8ba6704732dec","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[4065]: Traceback (most recent call last): Mar 08 09:50:27 volumio volumio[4065]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:27 volumio volumio[4065]: from aiohttp import web Mar 08 09:50:27 volumio volumio[4065]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:0X67jDdNTccPE8LCm8fT6r in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:0X67jDdNTccPE8LCm8fT6r Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5Ihd9HrPvOADyVoonH9ZjB","service":"spop","name":"Un-Break My Heart","artist":"Toni Braxton","album":"Secrets","type":"song","duration":270,"albumart":"https://i.scdn.co/image/ab67616d0000b2735bc7429f54c5f6745c225fc6","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:5vDMbf8GHZhbyqxBLy5PKp in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5vDMbf8GHZhbyqxBLy5PKp Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:51uTbPmQnApLyfnfn0bpC7","service":"spop","name":"I'm Not Gonna Let You - 12\" Extended Version","artist":"Colonel Abrams","album":"Best Of Colonel Abrams","type":"song","duration":412,"albumart":"https://i.scdn.co/image/ab67616d0000b273a514df78371f18954291de22","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0X67jDdNTccPE8LCm8fT6r","service":"spop","name":"U Got It Bad - Soulpower Remix","artist":"USHER","album":"12\" Masters - The Essential Mixes","type":"song","duration":247,"albumart":"https://i.scdn.co/image/ab67616d0000b273135612675a5f67e1101f5c88","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:6yg5A6yiu5kDN9Kiil7iUr in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6yg5A6yiu5kDN9Kiil7iUr Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:5Fy40smNxk0j5OpFMtvfaU in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5Fy40smNxk0j5OpFMtvfaU Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5vDMbf8GHZhbyqxBLy5PKp","service":"spop","name":"Makin' Happy - Hurley’s Happy House Mix","artist":"Crystal Waters","album":"Makin' Happy (Remixes)","type":"song","duration":379,"albumart":"https://i.scdn.co/image/ab67616d0000b2737c8dd10b3ae834e2538533c6","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:0YC3WfFZkZBpUeaHt4Eggk in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:0YC3WfFZkZBpUeaHt4Eggk Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5Fy40smNxk0j5OpFMtvfaU","service":"spop","name":"In the Closet","artist":"Michael Jackson","album":"Dangerous","type":"song","duration":390,"albumart":"https://i.scdn.co/image/ab67616d0000b2733b9f8b18cc685e1502128aa8","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:6mcmKco5obfTkhNsCghgeq in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6mcmKco5obfTkhNsCghgeq Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6yg5A6yiu5kDN9Kiil7iUr","service":"spop","name":"If I Had No Loot","artist":"Tony! Toni! Toné!","album":"Tony Toni Tones","type":"song","duration":65,"albumart":"https://i.scdn.co/image/ab67616d0000b27334dbf8631eeaee52bf8d68bf","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0YC3WfFZkZBpUeaHt4Eggk","service":"spop","name":"Turn the Music Louder (Rumble) (feat. Tinie Tempah) - Radio Edit","artist":"KDA","album":"Turn the Music Louder (Rumble) (feat. Tinie Tempah) [Radio Edit]","type":"song","duration":201,"albumart":"https://i.scdn.co/image/ab67616d0000b273d3699e3e6441ba4672c178a2","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:27 volumio volumio[987]: info: Exploding uri spotify:track:77CA8SLEVa62gmW0s7Td4A in service spop Mar 08 09:50:27 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:77CA8SLEVa62gmW0s7Td4A Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6mcmKco5obfTkhNsCghgeq","service":"spop","name":"Dundaing","artist":"King Kaka","album":"Eastlando Royalty","type":"song","duration":192,"albumart":"https://i.scdn.co/image/ab67616d0000b273e63ac82c280fdb3989fd3ea7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:1fUKZpXy4XfxCLEFE7WaW9 in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1fUKZpXy4XfxCLEFE7WaW9 Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:77CA8SLEVa62gmW0s7Td4A","service":"spop","name":"Telephone Love","artist":"J.C. Lodge","album":"Telephone Love","type":"song","duration":206,"albumart":"https://i.scdn.co/image/ab67616d0000b2733ff5b0aea9f1d45a3b12b8ac","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:6MCoVicJXlNSLh5lETQJxe in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6MCoVicJXlNSLh5lETQJxe Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1fUKZpXy4XfxCLEFE7WaW9","service":"spop","name":"Come into My Life","artist":"Joyce Sims","album":"Come into My Life","type":"song","duration":469,"albumart":"https://i.scdn.co/image/ab67616d0000b273580eeec5fba66ab816c54845","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:1mMYaXpT65iZDtvfRA9EkE in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1mMYaXpT65iZDtvfRA9EkE Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:3sPKULZYV344Xn6yx8I1rH in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:3sPKULZYV344Xn6yx8I1rH Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6MCoVicJXlNSLh5lETQJxe","service":"spop","name":"Things We Do For Love","artist":"Horace Brown","album":"Horace Brown","type":"song","duration":297,"albumart":"https://i.scdn.co/image/ab67616d0000b273db22955cdb5f59db72649ed6","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:6GS6uE1vDmtzxO8GztAR2O in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6GS6uE1vDmtzxO8GztAR2O Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1mMYaXpT65iZDtvfRA9EkE","service":"spop","name":"Fresh","artist":"Kool & The Gang","album":"Emergency (Reissue)","type":"song","duration":266,"albumart":"https://i.scdn.co/image/ab67616d0000b2730afe71cef9e2f4db5ebfcc82","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3sPKULZYV344Xn6yx8I1rH","service":"spop","name":"So Amazing","artist":"Luther Vandross","album":"The Greatest Hits","type":"song","duration":219,"albumart":"https://i.scdn.co/image/ab67616d0000b273f7d35b184d8fb844cf2ef667","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:6fh2SXy67ei7fzpXMIktY7 in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6fh2SXy67ei7fzpXMIktY7 Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:1KQsKh9ecjGvF0uEIuwe0a in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6GS6uE1vDmtzxO8GztAR2O","service":"spop","name":"Two To Make It Right","artist":"Seduction","album":"Nothing Matters Without Love","type":"song","duration":282,"albumart":"https://i.scdn.co/image/ab67616d0000b27319b805cdb8ece5b408b143fa","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6fh2SXy67ei7fzpXMIktY7","service":"spop","name":"Lady Baby - Roy Mix (Radio Edit)","artist":"Fe-nix","album":"Lady Baby","type":"song","duration":204,"albumart":"https://i.scdn.co/image/ab67616d0000b273b9ed0f9dde987e56b7e4889c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:1KQsKh9ecjGvF0uEIuwe0a in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1KQsKh9ecjGvF0uEIuwe0a","service":"spop","name":"Come and Get with Me (feat. Snoop Dogg) - Single Version; 2007 Remaster","artist":"Keith Sweat","album":"The Best of Keith Sweat: Make You Sweat","type":"song","duration":293,"albumart":"https://i.scdn.co/image/ab67616d0000b273820facd82ca670c50ee97f39","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:0u2CGItUO2jYEiFaXD7n5S in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:0u2CGItUO2jYEiFaXD7n5S Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1KQsKh9ecjGvF0uEIuwe0a","service":"spop","name":"Come and Get with Me (feat. Snoop Dogg) - Single Version; 2007 Remaster","artist":"Keith Sweat","album":"The Best of Keith Sweat: Make You Sweat","type":"song","duration":293,"albumart":"https://i.scdn.co/image/ab67616d0000b273820facd82ca670c50ee97f39","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:7py16W5fWYLFFS6BElKAjn in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:7py16W5fWYLFFS6BElKAjn Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:0yNCFwihschpOwSgK31f2O in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:0yNCFwihschpOwSgK31f2O Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0u2CGItUO2jYEiFaXD7n5S","service":"spop","name":"Wishing on a Star","artist":"Rose Royce","album":"In Full Bloom","type":"song","duration":291,"albumart":"https://i.scdn.co/image/ab67616d0000b273a9dd6842b248f3881167199e","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:3SmPl0CGxvvkQCrTv7edEE in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:3SmPl0CGxvvkQCrTv7edEE Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7py16W5fWYLFFS6BElKAjn","service":"spop","name":"Tears (feat. Louisa Johnson)","artist":"Clean Bandit","album":"Tears (feat. Louisa Johnson)","type":"song","duration":225,"albumart":"https://i.scdn.co/image/ab67616d0000b2737ed82049cec82ea803874d2c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:6nXzKd8oA6N1qgG1vMZUKe in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6nXzKd8oA6N1qgG1vMZUKe Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:4IYKjN1DrYzxKXt0umJqsG in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4IYKjN1DrYzxKXt0umJqsG Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0yNCFwihschpOwSgK31f2O","service":"spop","name":"Hit Me Off","artist":"New Edition","album":"Home Again","type":"song","duration":261,"albumart":"https://i.scdn.co/image/ab67616d0000b273ef1bbba1b15f6aa21b484ea4","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:6HF0YzbYubg86ucne1NdaF in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6HF0YzbYubg86ucne1NdaF Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6nXzKd8oA6N1qgG1vMZUKe","service":"spop","name":"I Miss You (Come Back Home)","artist":"Monifah","album":"Moods...Moments","type":"song","duration":233,"albumart":"https://i.scdn.co/image/ab67616d0000b273e837569b3bb3e9820b5c318b","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3SmPl0CGxvvkQCrTv7edEE","service":"spop","name":"I'm Your Baby Tonight","artist":"Whitney Houston","album":"I'm Your Baby Tonight","type":"song","duration":299,"albumart":"https://i.scdn.co/image/ab67616d0000b27302dffd583e3bc8eff1ad471b","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4IYKjN1DrYzxKXt0umJqsG","service":"spop","name":"I Got 5 On It","artist":"Luniz","album":"Operation Stackola","type":"song","duration":253,"albumart":"https://i.scdn.co/image/ab67616d0000b273c1ea4aac1ad07a38c59dd30c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:2cG8UHHDmVEa7H1U1cG96I in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:2cG8UHHDmVEa7H1U1cG96I Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:13UqMPlV7MW7PLrET9L7cm in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6HF0YzbYubg86ucne1NdaF","service":"spop","name":"Ain't 2 Proud 2 Beg - Skratch & Sniff 7\" Edit","artist":"TLC","album":"Ain't 2 Proud 2 Beg (Remixes)","type":"song","duration":263,"albumart":"https://i.scdn.co/image/ab67616d0000b273ac892ccbec64ccff73f57162","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:13UqMPlV7MW7PLrET9L7cm in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:13UqMPlV7MW7PLrET9L7cm","service":"spop","name":"Never Gonna Let You Go - Kelly G. Bump-N-Go Vocal Edit","artist":"Tina Moore","album":"Pure... R&B","type":"song","duration":252,"albumart":"https://i.scdn.co/image/ab67616d0000b2739b1820360f9bb9767e1ea22a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2cG8UHHDmVEa7H1U1cG96I","service":"spop","name":"It's a Love Thing (Single Version)","artist":"The Whispers","album":"Imagination","type":"song","duration":227,"albumart":"https://i.scdn.co/image/ab67616d0000b2736a9003b9c53104a4ac8306cd","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:5c33j1xFVOL4G24zxYhssB in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5c33j1xFVOL4G24zxYhssB Mar 08 09:50:28 volumio volumio[987]: info: Exploding uri spotify:track:3D6xxbFiyPRduSUowHbjSP in service spop Mar 08 09:50:28 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:3D6xxbFiyPRduSUowHbjSP Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:13UqMPlV7MW7PLrET9L7cm","service":"spop","name":"Never Gonna Let You Go - Kelly G. Bump-N-Go Vocal Edit","artist":"Tina Moore","album":"Pure... R&B","type":"song","duration":252,"albumart":"https://i.scdn.co/image/ab67616d0000b2739b1820360f9bb9767e1ea22a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:2H2gRsnrQ9AAhyyxdoLk7U in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:2H2gRsnrQ9AAhyyxdoLk7U Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5c33j1xFVOL4G24zxYhssB","service":"spop","name":"This Old Heart Of Mine (Is Weak For You)","artist":"The Isley Brothers","album":"This Old Heart Of Mine","type":"song","duration":172,"albumart":"https://i.scdn.co/image/ab67616d0000b27363509e860d6373c622b3cc8c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3D6xxbFiyPRduSUowHbjSP","service":"spop","name":"Something In Common","artist":"Whitney Houston","album":"Bobby","type":"song","duration":299,"albumart":"https://i.scdn.co/image/ab67616d0000b273706965d1da3fb77d19fe421f","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:1cLAkZ6dGFV10C8q1BJAca in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2H2gRsnrQ9AAhyyxdoLk7U","service":"spop","name":"Monie","artist":"Kanda Bongo Man","album":"Zing Zong","type":"song","duration":288,"albumart":"https://i.scdn.co/image/ab67616d0000b273fef64c3ca91c1b82b4b88507","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:1ur5N3DQS8JX686I0xmRhs in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1ur5N3DQS8JX686I0xmRhs Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:1cLAkZ6dGFV10C8q1BJAca in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1cLAkZ6dGFV10C8q1BJAca","service":"spop","name":"Muzina","artist":"Tabu Ley Rochereau","album":"Muzina","type":"song","duration":462,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ed17a911a788e498c4f0ff9","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:6LiK3fDottplOUsLHfhXto in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6LiK3fDottplOUsLHfhXto Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1ur5N3DQS8JX686I0xmRhs","service":"spop","name":"Letter To My Grandma","artist":"Lastyungan","album":"Diary Of A CEO","type":"song","duration":132,"albumart":"https://i.scdn.co/image/ab67616d0000b2731e08ccb5104a5b7f8c3a474f","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:4PyhlL1vrSvPlhYLdphszr in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4PyhlL1vrSvPlhYLdphszr Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1cLAkZ6dGFV10C8q1BJAca","service":"spop","name":"Muzina","artist":"Tabu Ley Rochereau","album":"Muzina","type":"song","duration":462,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ed17a911a788e498c4f0ff9","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:4zl7r00yVvYPS8gZriSS6X in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4zl7r00yVvYPS8gZriSS6X Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6LiK3fDottplOUsLHfhXto","service":"spop","name":"Here Comes the Hotstepper","artist":"iNi Kamoze","album":"90s 100 Hits","type":"song","duration":249,"albumart":"https://i.scdn.co/image/ab67616d0000b273b212e660aec81b60a425d4f1","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4PyhlL1vrSvPlhYLdphszr","service":"spop","name":"Big Fun","artist":"Inner City","album":"Paradise","type":"song","duration":206,"albumart":"https://i.scdn.co/image/ab67616d0000b2734573e6f96afc42c80f3ed183","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:6Afrv2uPWjlKJvMPlpsBxP in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6Afrv2uPWjlKJvMPlpsBxP Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4zl7r00yVvYPS8gZriSS6X","service":"spop","name":"Dreamer","artist":"The B. B. & Q. Band","album":"Genie (Expanded Edition)","type":"song","duration":347,"albumart":"https://i.scdn.co/image/ab67616d0000b27310bba8893882324306496a7a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:01JRVFY79m7784ArNpd41F in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:01JRVFY79m7784ArNpd41F Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6Afrv2uPWjlKJvMPlpsBxP","service":"spop","name":"Eyes On You - Radio Mix","artist":"Jay Sean","album":"Eyes On You","type":"song","duration":192,"albumart":"https://i.scdn.co/image/ab67616d0000b273930ae2f3df09c8c0ef07cb71","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:742hY2twqAjwNYnKkQdilj in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:742hY2twqAjwNYnKkQdilj Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:01JRVFY79m7784ArNpd41F","service":"spop","name":"Don't Let Go (Love) - Radio Edit","artist":"En Vogue","album":"R&B: The Collection","type":"song","duration":244,"albumart":"https://i.scdn.co/image/ab67616d0000b27389a1a9609c9d1eac7b2eca56","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:5IhBjmG7k7z9HVkvPl17N5 in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:5eFCFpmDbqGqpdOVE9CXCh in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5eFCFpmDbqGqpdOVE9CXCh Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:742hY2twqAjwNYnKkQdilj","service":"spop","name":"Strike It Up","artist":"Black Box","album":"Dreamland","type":"song","duration":298,"albumart":"https://i.scdn.co/image/ab67616d0000b273ae03a889dd876866982b309a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:5IhBjmG7k7z9HVkvPl17N5 in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5IhBjmG7k7z9HVkvPl17N5","service":"spop","name":"I'm In Love","artist":"Evelyn \"Champagne\" King","album":"I'm In Love (Expanded Edition)","type":"song","duration":305,"albumart":"https://i.scdn.co/image/ab67616d0000b2730324346680f1128ad8f9a685","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Using cached record of: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5IhBjmG7k7z9HVkvPl17N5","service":"spop","name":"I'm In Love","artist":"Evelyn \"Champagne\" King","album":"I'm In Love (Expanded Edition)","type":"song","duration":305,"albumart":"https://i.scdn.co/image/ab67616d0000b2730324346680f1128ad8f9a685","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: info: Exploding uri spotify:track:6JrAEmBFd61eYIGVOSPnT4 in service spop Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:6JrAEmBFd61eYIGVOSPnT4 Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5eFCFpmDbqGqpdOVE9CXCh","service":"spop","name":"That's the Way Love Is - Underground Mix; Edit","artist":"Ten City","album":"Foundation","type":"song","duration":255,"albumart":"https://i.scdn.co/image/ab67616d0000b2730b69a1a1e9e6c46eff17305a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6JrAEmBFd61eYIGVOSPnT4","service":"spop","name":"Wicked Games (feat. Anna Naklab) - Radio Edit","artist":"Parra for Cuva","album":"Wicked Games (feat. Anna Naklab) [Radio Edit]","type":"song","duration":195,"albumart":"https://i.scdn.co/image/ab67616d0000b273f2f0dd42bfacec09ba35db83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 08 09:50:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 347. Mar 08 09:50:29 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:29 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:29 volumio volumio[4083]: Traceback (most recent call last): Mar 08 09:50:29 volumio volumio[4083]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:29 volumio volumio[4083]: from aiohttp import web Mar 08 09:50:29 volumio volumio[4083]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:29 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:29 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 348. Mar 08 09:50:32 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:32 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:32 volumio volumio[4084]: Traceback (most recent call last): Mar 08 09:50:32 volumio volumio[4084]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:32 volumio volumio[4084]: from aiohttp import web Mar 08 09:50:32 volumio volumio[4084]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:32 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:32 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:32 volumio volumio[987]: info: Preload queue cleared Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::ClearQueue Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::stop Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::serviceStop Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::serviceStop Mar 08 09:50:32 volumio volumio[987]: info: ControllerMpd::stop Mar 08 09:50:32 volumio volumio[987]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::clearPlayQueue Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::addQueueItems Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::addQueueItems Mar 08 09:50:32 volumio volumio[987]: info: Preload queue cleared Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::play index 0 Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::addQueueItems Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::addQueueItems Mar 08 09:50:32 volumio volumio[987]: info: Preload queue cleared Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4WuxxGa7qAMBpNFFyHsLlE Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6GqRnLm8b3RLHOmDinAbYt Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6GqRnLm8b3RLHOmDinAbYt Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1PtJclc46wTk367PlsU6Uj Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1PtJclc46wTk367PlsU6Uj Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5Ihd9HrPvOADyVoonH9ZjB Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5Ihd9HrPvOADyVoonH9ZjB Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:51uTbPmQnApLyfnfn0bpC7 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:51uTbPmQnApLyfnfn0bpC7 Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:0X67jDdNTccPE8LCm8fT6r Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:0X67jDdNTccPE8LCm8fT6r Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5vDMbf8GHZhbyqxBLy5PKp Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5vDMbf8GHZhbyqxBLy5PKp Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6yg5A6yiu5kDN9Kiil7iUr Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6yg5A6yiu5kDN9Kiil7iUr Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5Fy40smNxk0j5OpFMtvfaU Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5Fy40smNxk0j5OpFMtvfaU Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:0YC3WfFZkZBpUeaHt4Eggk Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:0YC3WfFZkZBpUeaHt4Eggk Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6mcmKco5obfTkhNsCghgeq Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6mcmKco5obfTkhNsCghgeq Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:77CA8SLEVa62gmW0s7Td4A Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:77CA8SLEVa62gmW0s7Td4A Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1fUKZpXy4XfxCLEFE7WaW9 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1fUKZpXy4XfxCLEFE7WaW9 Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6MCoVicJXlNSLh5lETQJxe Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6MCoVicJXlNSLh5lETQJxe Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1mMYaXpT65iZDtvfRA9EkE Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1mMYaXpT65iZDtvfRA9EkE Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:3sPKULZYV344Xn6yx8I1rH Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:3sPKULZYV344Xn6yx8I1rH Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6GS6uE1vDmtzxO8GztAR2O Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6GS6uE1vDmtzxO8GztAR2O Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6fh2SXy67ei7fzpXMIktY7 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6fh2SXy67ei7fzpXMIktY7 Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1KQsKh9ecjGvF0uEIuwe0a Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:0u2CGItUO2jYEiFaXD7n5S Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:0u2CGItUO2jYEiFaXD7n5S Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:7py16W5fWYLFFS6BElKAjn Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:7py16W5fWYLFFS6BElKAjn Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:0yNCFwihschpOwSgK31f2O Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:0yNCFwihschpOwSgK31f2O Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:3SmPl0CGxvvkQCrTv7edEE Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:3SmPl0CGxvvkQCrTv7edEE Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6nXzKd8oA6N1qgG1vMZUKe Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6nXzKd8oA6N1qgG1vMZUKe Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4IYKjN1DrYzxKXt0umJqsG Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4IYKjN1DrYzxKXt0umJqsG Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6HF0YzbYubg86ucne1NdaF Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6HF0YzbYubg86ucne1NdaF Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:2cG8UHHDmVEa7H1U1cG96I Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:2cG8UHHDmVEa7H1U1cG96I Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:13UqMPlV7MW7PLrET9L7cm Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5c33j1xFVOL4G24zxYhssB Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5c33j1xFVOL4G24zxYhssB Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:3D6xxbFiyPRduSUowHbjSP Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:3D6xxbFiyPRduSUowHbjSP Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:2H2gRsnrQ9AAhyyxdoLk7U Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:2H2gRsnrQ9AAhyyxdoLk7U Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1ur5N3DQS8JX686I0xmRhs Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1ur5N3DQS8JX686I0xmRhs Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:1cLAkZ6dGFV10C8q1BJAca Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6LiK3fDottplOUsLHfhXto Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6LiK3fDottplOUsLHfhXto Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4PyhlL1vrSvPlhYLdphszr Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4PyhlL1vrSvPlhYLdphszr Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:4zl7r00yVvYPS8gZriSS6X Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:4zl7r00yVvYPS8gZriSS6X Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6Afrv2uPWjlKJvMPlpsBxP Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6Afrv2uPWjlKJvMPlpsBxP Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:01JRVFY79m7784ArNpd41F Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:01JRVFY79m7784ArNpd41F Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:742hY2twqAjwNYnKkQdilj Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:742hY2twqAjwNYnKkQdilj Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5eFCFpmDbqGqpdOVE9CXCh Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5eFCFpmDbqGqpdOVE9CXCh Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:5IhBjmG7k7z9HVkvPl17N5 Mar 08 09:50:32 volumio volumio[987]: info: Adding Item to queue: spotify:track:6JrAEmBFd61eYIGVOSPnT4 Mar 08 09:50:32 volumio volumio[987]: info: Using cached record of: spotify:track:6JrAEmBFd61eYIGVOSPnT4 Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::stop Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::stPlaybackTimer Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:50:32 volumio volumio[987]: info: CoreStateMachine::serviceStop Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::serviceStop Mar 08 09:50:32 volumio volumio[987]: info: Spotify Stop Mar 08 09:50:32 volumio volumio[987]: SPOTIFY: SPOTIFY STOP Mar 08 09:50:32 volumio volumio[987]: SPOTIFY: {"status":"play","title":"M/A/R/R/S - Pump Up the Volume (UK 12\" Mix)","artist":"80s80s Partyhits","album":null,"albumart":"/albumart","uri":"http://streams.80s80s.de/party/mp3-192/volumio","trackType":"","codec":"","seek":115748,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"repeat":false,"consume":false,"volume":58,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"volatile":true} Mar 08 09:50:32 volumio volumio[987]: info: Sending Spotify command to local API: /player/pause Mar 08 09:50:32 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 08 09:50:32 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: info: [1741427433005] ControllerSpotify::clearAddPlayTrack Mar 08 09:50:33 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:50:33 volumio volumio[987]: info: Mar 08 09:50:33 volumio volumio[987]: ---------------------------- MPD announces state update: player Mar 08 09:50:33 volumio volumio[987]: info: sendMpdCommand stop took 66 milliseconds Mar 08 09:50:33 volumio volumio[987]: info: ControllerMpd::getState Mar 08 09:50:33 volumio volumio[987]: verbose: ControllerMpd::sendMpdCommand status Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="pause track at 21998ms" Mar 08 09:50:33 volumio volumio[987]: info: sendMpdCommand status took 3 milliseconds Mar 08 09:50:33 volumio volumio[987]: verbose: ControllerMpd::parseState Mar 08 09:50:33 volumio volumio[987]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 09:50:33 volumio volumio[987]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 09:50:33 volumio volumio[987]: verbose: ControllerMpd::parseTrackInfo Mar 08 09:50:33 volumio volumio[987]: info: ControllerMpd::pushState Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Mar 08 09:50:33 volumio volumio[987]: info: ------------------------------ 16ms Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="resolved context of track" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="shuffled context with seed 7596980775790232070 (len: 1, keep: -1)" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="emitting websocket event: will_play" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="selected format OGG_VORBIS_320 (50e8d123a68ea6f77162df041205354e0f7dcb93)" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="requested aes key for file 50e8d123a68ea6f77162df041205354e0f7dcb93, gid: 4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","play_origin":"go-librespot"}} Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="fetched first chunk of 15, total size is 7675863 bytes" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=info msg="loaded track \"ANGUKA NAYO\" (paused: false, position: 0ms, duration: 195056ms, prefetched: false)" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="fetched chunk 3/14, size: 524288" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="fetched chunk 1/14, size: 524288" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:33 volumio volumio[987]: error: FusionDsp - WebSocket error: [object Object] Mar 08 09:50:33 volumio volumio[987]: info: camilladsp spawned new process with pid 4090, instance 1, run: true Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="scheduling prefetch in 165s" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="emitting websocket event: metadata" Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","name":"ANGUKA NAYO","artist_names":["From The Hood Music","Wadaglizke"],"album_name":"ANGUKA NAYO","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","position":0,"duration":195056,"release_date":"year:2024 month:6 day:21","track_number":1,"disc_number":1}} Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="emitting websocket event: paused" Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","play_origin":"go-librespot"}} Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: PUSH STATE SPOTIFY Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: {"status":"pause","service":"spop","title":"ANGUKA NAYO","artist":"From The Hood Music, Wadaglizke","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","seek":0,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"ANGUKA NAYO","artist":"From The Hood Music, Wadaglizke","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","seek":0,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:50:33 volumio volumio[987]: verbose: CURRENT POSITION 0 Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::syncState stateService pause Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus stop Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:50:33 volumio go-librespot[1410]: time="2025-03-08T09:50:33Z" level=trace msg="emitting websocket event: playing" Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","play_origin":"go-librespot"}} Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: PUSH STATE SPOTIFY Mar 08 09:50:33 volumio volumio[987]: SPOTIFY: {"status":"play","service":"spop","title":"ANGUKA NAYO","artist":"From The Hood Music, Wadaglizke","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","seek":0,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:50:33 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:50:33 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:33 volumio volumio[987]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"ANGUKA NAYO","artist":"From The Hood Music, Wadaglizke","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","seek":0,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:50:33 volumio volumio[987]: verbose: CURRENT POSITION 0 Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Mar 08 09:50:33 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus stop Mar 08 09:50:33 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:50:34 volumio volumio[987]: SPOTIFY: PUSH STATE SPOTIFY Mar 08 09:50:34 volumio volumio[987]: SPOTIFY: {"status":"play","service":"spop","title":"ANGUKA NAYO","artist":"From The Hood Music, Wadaglizke","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","seek":0,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:50:34 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:50:34 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:34 volumio volumio[987]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"ANGUKA NAYO","artist":"From The Hood Music, Wadaglizke","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d00001e02d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","seek":0,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:50:34 volumio volumio[987]: verbose: CURRENT POSITION 0 Mar 08 09:50:34 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Mar 08 09:50:34 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus play Mar 08 09:50:34 volumio volumio[987]: info: Received an update from plugin. extracting info from payload Mar 08 09:50:34 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:50:34 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:34 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:50:34 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:50:34 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:50:34 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:50:34 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:34 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:34 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 349. Mar 08 09:50:34 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:34 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:34 volumio volumio[4098]: Traceback (most recent call last): Mar 08 09:50:34 volumio volumio[4098]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:34 volumio volumio[4098]: from aiohttp import web Mar 08 09:50:34 volumio volumio[4098]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:34 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:34 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:50:34 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:50:34 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:50:34 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:50:36 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:36 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 350. Mar 08 09:50:36 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:36 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:36 volumio volumio[4101]: Traceback (most recent call last): Mar 08 09:50:36 volumio volumio[4101]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:36 volumio volumio[4101]: from aiohttp import web Mar 08 09:50:36 volumio volumio[4101]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:36 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:36 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:38 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:38 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 351. Mar 08 09:50:38 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:38 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:38 volumio volumio[4102]: Traceback (most recent call last): Mar 08 09:50:38 volumio volumio[4102]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:38 volumio volumio[4102]: from aiohttp import web Mar 08 09:50:38 volumio volumio[4102]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:38 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:38 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:41 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:41 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 352. Mar 08 09:50:41 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:41 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:41 volumio volumio[4117]: Traceback (most recent call last): Mar 08 09:50:41 volumio volumio[4117]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:41 volumio volumio[4117]: from aiohttp import web Mar 08 09:50:41 volumio volumio[4117]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:41 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:41 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:43 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:43 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 353. Mar 08 09:50:43 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:43 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:43 volumio volumio[4118]: Traceback (most recent call last): Mar 08 09:50:43 volumio volumio[4118]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:43 volumio volumio[4118]: from aiohttp import web Mar 08 09:50:43 volumio volumio[4118]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:43 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:43 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:45 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:45 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 354. Mar 08 09:50:45 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:45 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:45 volumio volumio[4120]: Traceback (most recent call last): Mar 08 09:50:45 volumio volumio[4120]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:45 volumio volumio[4120]: from aiohttp import web Mar 08 09:50:45 volumio volumio[4120]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:45 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:45 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:46 volumio go-librespot[1410]: time="2025-03-08T09:50:46Z" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:50:47 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:47 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 355. Mar 08 09:50:47 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:47 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:47 volumio volumio[4121]: Traceback (most recent call last): Mar 08 09:50:47 volumio volumio[4121]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:47 volumio volumio[4121]: from aiohttp import web Mar 08 09:50:47 volumio volumio[4121]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:47 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:47 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:50 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:50 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 356. Mar 08 09:50:50 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:50 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:50 volumio volumio[4140]: Traceback (most recent call last): Mar 08 09:50:50 volumio volumio[4140]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:50 volumio volumio[4140]: from aiohttp import web Mar 08 09:50:50 volumio volumio[4140]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:50 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:50 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:52 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:52 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 357. Mar 08 09:50:52 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:52 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:52 volumio volumio[4141]: Traceback (most recent call last): Mar 08 09:50:52 volumio volumio[4141]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:52 volumio volumio[4141]: from aiohttp import web Mar 08 09:50:52 volumio volumio[4141]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:52 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:52 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:54 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:54 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 358. Mar 08 09:50:54 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:54 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:54 volumio volumio[4142]: Traceback (most recent call last): Mar 08 09:50:54 volumio volumio[4142]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:54 volumio volumio[4142]: from aiohttp import web Mar 08 09:50:54 volumio volumio[4142]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:56 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:56 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 359. Mar 08 09:50:56 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:56 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:56 volumio volumio[4143]: Traceback (most recent call last): Mar 08 09:50:56 volumio volumio[4143]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:56 volumio volumio[4143]: from aiohttp import web Mar 08 09:50:56 volumio volumio[4143]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:56 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:56 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:59 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:50:59 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 360. Mar 08 09:50:59 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:50:59 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:50:59 volumio volumio[4158]: Traceback (most recent call last): Mar 08 09:50:59 volumio volumio[4158]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:50:59 volumio volumio[4158]: from aiohttp import web Mar 08 09:50:59 volumio volumio[4158]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:50:59 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:50:59 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:50:59 volumio go-librespot[1410]: time="2025-03-08T09:50:59Z" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:4WuxxGa7qAMBpNFFyHsLlE" Mar 08 09:51:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 361. Mar 08 09:51:01 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:01 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:01 volumio volumio[4159]: Traceback (most recent call last): Mar 08 09:51:01 volumio volumio[4159]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:01 volumio volumio[4159]: from aiohttp import web Mar 08 09:51:01 volumio volumio[4159]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:01 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:01 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 362. Mar 08 09:51:03 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:03 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:03 volumio volumio[4160]: Traceback (most recent call last): Mar 08 09:51:03 volumio volumio[4160]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:03 volumio volumio[4160]: from aiohttp import web Mar 08 09:51:03 volumio volumio[4160]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 363. Mar 08 09:51:05 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:05 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:05 volumio volumio[4205]: Traceback (most recent call last): Mar 08 09:51:05 volumio volumio[4205]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:05 volumio volumio[4205]: from aiohttp import web Mar 08 09:51:05 volumio volumio[4205]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:08 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:08 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 364. Mar 08 09:51:08 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:08 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:08 volumio volumio[4206]: Traceback (most recent call last): Mar 08 09:51:08 volumio volumio[4206]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:08 volumio volumio[4206]: from aiohttp import web Mar 08 09:51:08 volumio volumio[4206]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:08 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:08 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=trace msg="closed output device because of stop command" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 250" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1978" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=debug msg="put connect state inactive" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=trace msg="emitting websocket event: inactive" Mar 08 09:51:09 volumio volumio[987]: SPOTIFY: received: {"type":"inactive","data":null} Mar 08 09:51:09 volumio volumio[987]: error: Failed to decode event: inactive Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=error msg="failed receiving dealer message" error="failed to get reader: received close frame: status = StatusGoingAway and reason = \"\"" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.1.191:51698->104.199.65.9:4070: use of closed network connection" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=debug msg="obtained new client token: AACVNKGId26M73EdSMsTkQhVJ6ir0iuX4UvIBI7dv/Ump8PtzxUv3a+izDXA+xXyOmRyHus+lT+u5ED6AMiv+ed/Lhg3kKgUb99FHWpxdlKtRcYgXMyLWUyfVFqekRKr8OYlnyiwNUWO/K/C0ak1bGJqw7LoUWIPpJWZ2qujwcupVGKSWDeTJJdZJ84XJK88k2S03gqtBAYMf3xLaKcDXxz4Jo4rOOB9JZ3m0i9KaOYAQtfZpUsKoOkTdUk5NBA=" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=info msg="connected to ap-gew1.spotify.com:4070" Mar 08 09:51:09 volumio go-librespot[1410]: time="2025-03-08T09:51:09Z" level=debug msg="completed keyexchange" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="completed challenge" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="authenticated as fish-e1" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="authenticated as fish-e1" Mar 08 09:51:10 volumio volumio[987]: info: camilladsp spawned new process with pid 4224, instance 1, run: true Mar 08 09:51:10 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:10 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 365. Mar 08 09:51:10 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="dealer connection opened" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="restored session after logout, username: fish-e1" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="autoplay enabled: false" Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="received connection id: ZWFlODFiYzUtMjIwZC00OWQ0LTk3NDEtODc5ZWUxNmU0ODk1K2RlYWxlcit0Y3A6Ly8wYWNhNDIzYy5pcC5nZXcxLnNwb3RpZnkubmV0OjU3MDArNkEzQUU0Rjg3QzlGM0E2MkVFNDVGOEI3MjE0MzU1MjQ1N0Q2MkU2QjJEOEYzRkZCRkQwMjBBRUYyQ0U1MDhGRg==" Mar 08 09:51:10 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:10 volumio volumio[4231]: Traceback (most recent call last): Mar 08 09:51:10 volumio volumio[4231]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:10 volumio volumio[4231]: from aiohttp import web Mar 08 09:51:10 volumio volumio[4231]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:10 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:10 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:10 volumio go-librespot[1410]: time="2025-03-08T09:51:10Z" level=debug msg="put connect state because NEW_DEVICE" Mar 08 09:51:11 volumio go-librespot[1410]: time="2025-03-08T09:51:11Z" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Mar 08 09:51:11 volumio go-librespot[1410]: time="2025-03-08T09:51:11Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 337" Mar 08 09:51:12 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:12 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 366. Mar 08 09:51:12 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:12 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:12 volumio volumio[4232]: Traceback (most recent call last): Mar 08 09:51:12 volumio volumio[4232]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:12 volumio volumio[4232]: from aiohttp import web Mar 08 09:51:12 volumio volumio[4232]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 367. Mar 08 09:51:14 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:14 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:14 volumio volumio[4233]: Traceback (most recent call last): Mar 08 09:51:14 volumio volumio[4233]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:14 volumio volumio[4233]: from aiohttp import web Mar 08 09:51:14 volumio volumio[4233]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 368. Mar 08 09:51:17 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:17 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:17 volumio volumio[4234]: Traceback (most recent call last): Mar 08 09:51:17 volumio volumio[4234]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:17 volumio volumio[4234]: from aiohttp import web Mar 08 09:51:17 volumio volumio[4234]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:17 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:17 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:19 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:19 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 369. Mar 08 09:51:19 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:19 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:19 volumio volumio[4249]: Traceback (most recent call last): Mar 08 09:51:19 volumio volumio[4249]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:19 volumio volumio[4249]: from aiohttp import web Mar 08 09:51:19 volumio volumio[4249]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:19 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:19 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:21 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:21 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 370. Mar 08 09:51:21 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:21 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:21 volumio volumio[4250]: Traceback (most recent call last): Mar 08 09:51:21 volumio volumio[4250]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:21 volumio volumio[4250]: from aiohttp import web Mar 08 09:51:21 volumio volumio[4250]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 371. Mar 08 09:51:23 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:23 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:23 volumio volumio[4251]: Traceback (most recent call last): Mar 08 09:51:23 volumio volumio[4251]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:23 volumio volumio[4251]: from aiohttp import web Mar 08 09:51:23 volumio volumio[4251]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 372. Mar 08 09:51:26 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:26 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:26 volumio volumio[4252]: Traceback (most recent call last): Mar 08 09:51:26 volumio volumio[4252]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:26 volumio volumio[4252]: from aiohttp import web Mar 08 09:51:26 volumio volumio[4252]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:26 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:26 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="handling transfer player command from bf0bb2eb8890341d41b9f28ccf86fdb3b3892618" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="resolved context of track" uri="spotify:user:fish-e1:collection" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="fetched new page 0 with 2474 items (list: 2474)" uri="spotify:user:fish-e1:collection" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="shuffled context with seed 14636635002052504704 (len: 2474, keep: 1390)" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="loading track (paused: false, position: 6653ms)" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="emitting websocket event: will_play" Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:3wlEt7tgbcyowpdlcnCwfz","play_origin":"playlist"}} Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="selected format OGG_VORBIS_320 (4127b83c220bca88648dbbd6dc5f253f9715dc8f)" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="requested aes key for file 4127b83c220bca88648dbbd6dc5f253f9715dc8f, gid: 3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2004" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="fetched first chunk of 18, total size is 9379156 bytes" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="seek to 6653ms (diff: 63ms, samples: 293397, bytes: 304658)" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="created new output device" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=info msg="loaded track \"Sauti\" (paused: false, position: 6653ms, duration: 208770ms, prefetched: false)" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="fetched chunk 1/17, size: 524288" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="fetched chunk 2/17, size: 524288" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="scheduling prefetch in 171s" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="emitting websocket event: metadata" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="emitting websocket event: active" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="sending successful reply for dealer request" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="fetched chunk 3/17, size: 524288" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=trace msg="emitting websocket event: playing" Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 08 09:51:27 volumio go-librespot[1410]: time="2025-03-08T09:51:27Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1446" Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:3wlEt7tgbcyowpdlcnCwfz","name":"Sauti","artist_names":["Francis Mercier","Faul \u0026 Wad","African Children's Choir"],"album_name":"Sauti","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02585d609a2d843529e8805150","position":6653,"duration":208770,"release_date":"year:2024 month:7 day:19","track_number":1,"disc_number":1}} Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: received: {"type":"active","data":null} Mar 08 09:51:27 volumio volumio[987]: info: Aligning Spotify Volume to Volumio Volume Mar 08 09:51:27 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 08 09:51:27 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 08 09:51:27 volumio volumio[987]: info: Setting Spotify Volume from Volumio: 58 Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:3wlEt7tgbcyowpdlcnCwfz","play_origin":"playlist"}} Mar 08 09:51:27 volumio volumio[987]: info: Spotify is playing in volatile mode Mar 08 09:51:27 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: UNSET VOLATILE Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: {"status":"play","position":0,"title":"ANGUKA NAYO","artist":"From The Hood Music","album":"ANGUKA NAYO","albumart":"https://i.scdn.co/image/ab67616d0000b273d1f37caf37639cd88c47a3b7","uri":"spotify:track:4WuxxGa7qAMBpNFFyHsLlE","trackType":"spotify","codec":"ogg","seek":0,"duration":195,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":true,"repeatSingle":false,"consume":false,"volume":58,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Mar 08 09:51:27 volumio volumio[987]: info: Setting Spotify stop after unset volatile call Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: PUSH STATE SPOTIFY Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: {"status":"play","service":"spop","title":"Sauti","artist":"Francis Mercier, Faul & Wad, African Children's Choir","album":"Sauti","albumart":"https://i.scdn.co/image/ab67616d00001e02585d609a2d843529e8805150","uri":"spotify:track:3wlEt7tgbcyowpdlcnCwfz","trackType":"spotify","seek":6653,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 08 09:51:27 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:51:27 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:51:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:51:27 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:51:27 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:51:27 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:51:28 volumio volumio[987]: SPOTIFY: PUSH STATE SPOTIFY Mar 08 09:51:28 volumio volumio[987]: SPOTIFY: {"status":"play","service":"spop","title":"Sauti","artist":"Francis Mercier, Faul & Wad, African Children's Choir","album":"Sauti","albumart":"https://i.scdn.co/image/ab67616d00001e02585d609a2d843529e8805150","uri":"spotify:track:3wlEt7tgbcyowpdlcnCwfz","trackType":"spotify","seek":7653,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Mar 08 09:51:28 volumio volumio[987]: info: CoreCommandRouter::servicePushState Mar 08 09:51:28 volumio volumio[987]: info: CoreStateMachine::pushState Mar 08 09:51:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 09:51:28 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 08 09:51:28 volumio volumio[987]: info: FusionDsp - volume level for loudness 58 gain applied 0.00 Mar 08 09:51:28 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 08 09:51:28 volumio volumio[987]: info: FusionDsp - Loudness is ON true Mar 08 09:51:28 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 08 09:51:28 volumio volumio[987]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 08 09:51:28 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:28 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 373. Mar 08 09:51:28 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:28 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:28 volumio volumio[987]: info: Spotify Stop Mar 08 09:51:28 volumio volumio[987]: SPOTIFY: SPOTIFY STOP Mar 08 09:51:28 volumio volumio[987]: SPOTIFY: {"status":"play","title":"Sauti","artist":"Francis Mercier, Faul & Wad, African Children's Choir","album":"Sauti","albumart":"https://i.scdn.co/image/ab67616d00001e02585d609a2d843529e8805150","uri":"spotify:track:3wlEt7tgbcyowpdlcnCwfz","trackType":"spotify","codec":"ogg","seek":7653,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":58,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"volatile":true,"service":"spop"} Mar 08 09:51:28 volumio volumio[4258]: Traceback (most recent call last): Mar 08 09:51:28 volumio volumio[4258]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:28 volumio volumio[4258]: from aiohttp import web Mar 08 09:51:28 volumio volumio[4258]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:28 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:28 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:29 volumio volumio[987]: SPOTIFY: SETTING SPOTIFY VOLUME 58 Mar 08 09:51:29 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/volume Mar 08 09:51:29 volumio go-librespot[1410]: time="2025-03-08T09:51:29Z" level=debug msg="update volume to 38010/65535" Mar 08 09:51:29 volumio go-librespot[1410]: time="2025-03-08T09:51:29Z" level=debug msg="put connect state because VOLUME_CHANGED" Mar 08 09:51:29 volumio go-librespot[1410]: time="2025-03-08T09:51:29Z" level=trace msg="emitting websocket event: volume" Mar 08 09:51:29 volumio volumio[987]: SPOTIFY: received: {"type":"volume","data":{"value":58,"max":100}} Mar 08 09:51:29 volumio volumio[987]: SPOTIFY: RECEIVED SPOTIFY VOLUME 58 Mar 08 09:51:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 374. Mar 08 09:51:30 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:30 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:30 volumio volumio[4276]: Traceback (most recent call last): Mar 08 09:51:30 volumio volumio[4276]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:30 volumio volumio[4276]: from aiohttp import web Mar 08 09:51:30 volumio volumio[4276]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:30 volumio go-librespot[1410]: time="2025-03-08T09:51:30Z" level=debug msg="fetched chunk 4/17, size: 524288" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 375. Mar 08 09:51:32 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:32 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:32 volumio volumio[4277]: Traceback (most recent call last): Mar 08 09:51:32 volumio volumio[4277]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:32 volumio volumio[4277]: from aiohttp import web Mar 08 09:51:32 volumio volumio[4277]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:32 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:32 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 376. Mar 08 09:51:35 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:35 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:35 volumio volumio[4279]: Traceback (most recent call last): Mar 08 09:51:35 volumio volumio[4279]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:35 volumio volumio[4279]: from aiohttp import web Mar 08 09:51:35 volumio volumio[4279]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:35 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:35 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:37 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:37 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 377. Mar 08 09:51:37 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:37 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:37 volumio volumio[4280]: Traceback (most recent call last): Mar 08 09:51:37 volumio volumio[4280]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:37 volumio volumio[4280]: from aiohttp import web Mar 08 09:51:37 volumio volumio[4280]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:37 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:37 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:39 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:39 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 378. Mar 08 09:51:39 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:39 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:39 volumio volumio[4295]: Traceback (most recent call last): Mar 08 09:51:39 volumio volumio[4295]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:39 volumio volumio[4295]: from aiohttp import web Mar 08 09:51:39 volumio volumio[4295]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:41 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Mar 08 09:51:41 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 379. Mar 08 09:51:41 volumio systemd[1]: Stopped FusionDsp Daemon. Mar 08 09:51:41 volumio go-librespot[1410]: time="2025-03-08T09:51:41Z" level=debug msg="fetched chunk 5/17, size: 524288" uri="spotify:track:3wlEt7tgbcyowpdlcnCwfz" Mar 08 09:51:41 volumio systemd[1]: Started FusionDsp Daemon. Mar 08 09:51:41 volumio volumio[4297]: Traceback (most recent call last): Mar 08 09:51:41 volumio volumio[4297]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Mar 08 09:51:41 volumio volumio[4297]: from aiohttp import web Mar 08 09:51:41 volumio volumio[4297]: ModuleNotFoundError: No module named 'aiohttp' Mar 08 09:51:41 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Mar 08 09:51:41 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Mar 08 09:51:42 volumio volumio[987]: info: [1741427502885] [80s80s] Pushing the next song state Stacey Q - Two of Hearts and getting next track. Mar 08 09:51:42 volumio volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 09:51:42 volumio volumio[987]: TypeError: Cannot set property 'name' of undefined Mar 08 09:51:42 volumio volumio[987]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Mar 08 09:51:42 volumio volumio[987]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Mar 08 09:51:42 volumio volumio[987]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Mar 08 09:51:42 volumio volumio[987]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Mar 08 09:51:42 volumio volumio[987]: at processImmediate (internal/timers.js:461:21) Mar 08 09:51:42 volumio volumio[987]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 09:51:43 volumio sudo[4307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 09:50 Mar 08 09:51:43 volumio sudo[4307]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"