-- Logs begin at Thu 2019-02-14 18:11:58 HKT, end at Tue 2025-12-23 19:33:31 HKT. -- Dec 23 19:32:00 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 19:32:00 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 23 19:32:09 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 19:32:09 volumio volumio[877]: info: FusionDsp - Dec 23 19:32:09 volumio volumio[877]: info: FusionDsp - undefined Dec 23 19:32:24 volumio volumio[877]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Dec 23 19:32:24 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Dec 23 19:32:24 volumio volumio[877]: info: FusionDsp - Launching CamillaDsp GUI Dec 23 19:32:24 volumio volumio[877]: info: FusionDsp loaded Dec 23 19:32:24 volumio sudo[6391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 23 19:32:24 volumio sudo[6391]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:32:24 volumio volumio[877]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 23 19:32:24 volumio volumio[877]: error: FusionDsp - WebSocket error: [object Object] Dec 23 19:32:24 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 19:32:24 volumio volumio[877]: info: CoreCommandRouter::Close All Modals sent Dec 23 19:32:24 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:24 volumio sudo[6391]: pam_unix(sudo:session): session closed for user root Dec 23 19:32:24 volumio volumio[877]: info: FusionDsp - IP adress is ---------------------------127.0.0.1 Dec 23 19:32:24 volumio volumio[877]: info: FusionDsp - Dec 23 19:32:24 volumio volumio[6393]: Traceback (most recent call last): Dec 23 19:32:24 volumio volumio[6393]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:24 volumio volumio[6393]: from aiohttp import web Dec 23 19:32:24 volumio volumio[6393]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:24 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:24 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:25 volumio volumio[877]: info: FusionDsp - undefined Dec 23 19:32:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Dec 23 19:32:26 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:27 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:27 volumio volumio[6394]: Traceback (most recent call last): Dec 23 19:32:27 volumio volumio[6394]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:27 volumio volumio[6394]: from aiohttp import web Dec 23 19:32:27 volumio volumio[6394]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2. Dec 23 19:32:29 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:29 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:29 volumio volumio[6395]: Traceback (most recent call last): Dec 23 19:32:29 volumio volumio[6395]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:29 volumio volumio[6395]: from aiohttp import web Dec 23 19:32:29 volumio volumio[6395]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:29 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:29 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:31 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:31 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 3. Dec 23 19:32:31 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:31 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:31 volumio volumio[6410]: Traceback (most recent call last): Dec 23 19:32:31 volumio volumio[6410]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:31 volumio volumio[6410]: from aiohttp import web Dec 23 19:32:31 volumio volumio[6410]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:31 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:31 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:33 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:33 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 4. Dec 23 19:32:33 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:33 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:33 volumio volumio[6411]: Traceback (most recent call last): Dec 23 19:32:33 volumio volumio[6411]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:33 volumio volumio[6411]: from aiohttp import web Dec 23 19:32:33 volumio volumio[6411]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:33 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:33 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 5. Dec 23 19:32:35 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:36 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:36 volumio volumio[6414]: Traceback (most recent call last): Dec 23 19:32:36 volumio volumio[6414]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:36 volumio volumio[6414]: from aiohttp import web Dec 23 19:32:36 volumio volumio[6414]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:36 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:36 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:38 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:38 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 6. Dec 23 19:32:38 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:38 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:38 volumio volumio[6415]: Traceback (most recent call last): Dec 23 19:32:38 volumio volumio[6415]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:38 volumio volumio[6415]: from aiohttp import web Dec 23 19:32:38 volumio volumio[6415]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:38 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:38 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:40 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:40 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 7. Dec 23 19:32:40 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:40 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:40 volumio volumio[6468]: Traceback (most recent call last): Dec 23 19:32:40 volumio volumio[6468]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:40 volumio volumio[6468]: from aiohttp import web Dec 23 19:32:40 volumio volumio[6468]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:40 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:40 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:42 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:42 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 8. Dec 23 19:32:42 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:42 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:42 volumio volumio[6472]: Traceback (most recent call last): Dec 23 19:32:42 volumio volumio[6472]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:42 volumio volumio[6472]: from aiohttp import web Dec 23 19:32:42 volumio volumio[6472]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:42 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:42 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::volumioPlay Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::play index undefined Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::startPlaybackTimer Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: info: ControllerMpd::resume Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand play Dec 23 19:32:43 volumio volumio[877]: info: FusionDsp - ---- read samplerate, raw: 352800,S32_LE,2,32 Dec 23 19:32:43 volumio volumio[877]: info: FusionDsp - ---- read samplerate from file: 352800 Dec 23 19:32:43 volumio volumio[877]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 23 19:32:43 volumio volumio[877]: info: FusionDsp - ---- read samplerate, raw: 352800,S32_LE,2,32 Dec 23 19:32:43 volumio volumio[877]: info: FusionDsp - ---- read samplerate from file: 352800 Dec 23 19:32:43 volumio volumio[877]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 23 19:32:43 volumio volumio[877]: info: Dec 23 19:32:43 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:32:43 volumio volumio[877]: info: sendMpdCommand play took 28 milliseconds Dec 23 19:32:43 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:32:43 volumio volumio[877]: info: Dec 23 19:32:43 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:32:43 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:32:43 volumio volumio[877]: info: sendMpdCommand status took 2 milliseconds Dec 23 19:32:43 volumio volumio[877]: info: sendMpdCommand status took 2 milliseconds Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:32:43 volumio volumio[877]: error: FusionDsp - WebSocket error: [object Object] Dec 23 19:32:43 volumio volumio[877]: error: FusionDsp - WebSocket error: [object Object] Dec 23 19:32:43 volumio volumio[877]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 19:32:43 volumio volumio[877]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:32:43 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:32:43 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3755,"duration":214,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"晚風 (Night Breeze)","artist":"Vincy Chan (泳兒)","album":"Fever [Mora DSF DSD128/5,6MHz]","uri":"NAS/Vmusic/1.DSD128/泳兒/泳兒 - Fever [Mora DSF DSD128 5,6MHz]/05-晚風 (Night Breeze).dsf","trackType":"dsf"} Dec 23 19:32:43 volumio volumio[877]: verbose: CURRENT POSITION 4 Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::syncState stateService play Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus pause Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:32:43 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3755,"duration":214,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"晚風 (Night Breeze)","artist":"Vincy Chan (泳兒)","album":"Fever [Mora DSF DSD128/5,6MHz]","uri":"NAS/Vmusic/1.DSD128/泳兒/泳兒 - Fever [Mora DSF DSD128 5,6MHz]/05-晚風 (Night Breeze).dsf","trackType":"dsf"} Dec 23 19:32:43 volumio volumio[877]: verbose: CURRENT POSITION 4 Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::syncState stateService play Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus play Dec 23 19:32:43 volumio volumio[877]: info: Received an update from plugin. extracting info from payload Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:32:43 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:32:43 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:43 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:32:43 volumio volumio[877]: info: ------------------------------ 37ms Dec 23 19:32:43 volumio volumio[877]: info: ------------------------------ 35ms Dec 23 19:32:44 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:44 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9. Dec 23 19:32:44 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:45 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:45 volumio volumio[6474]: Traceback (most recent call last): Dec 23 19:32:45 volumio volumio[6474]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:45 volumio volumio[6474]: from aiohttp import web Dec 23 19:32:45 volumio volumio[6474]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:45 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:45 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:47 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:47 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 10. Dec 23 19:32:47 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:47 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:47 volumio volumio[6475]: Traceback (most recent call last): Dec 23 19:32:47 volumio volumio[6475]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:47 volumio volumio[6475]: from aiohttp import web Dec 23 19:32:47 volumio volumio[6475]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:47 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:47 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:49 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:49 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 11. Dec 23 19:32:49 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:49 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:49 volumio volumio[6476]: Traceback (most recent call last): Dec 23 19:32:49 volumio volumio[6476]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:49 volumio volumio[6476]: from aiohttp import web Dec 23 19:32:49 volumio volumio[6476]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:49 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:49 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::volumioPause Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::pause Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::servicePause Dec 23 19:32:51 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::servicePause Dec 23 19:32:51 volumio volumio[877]: info: ControllerMpd::pause Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand pause Dec 23 19:32:51 volumio volumio[877]: info: sendMpdCommand pause took 0 milliseconds Dec 23 19:32:51 volumio volumio[877]: info: Dec 23 19:32:51 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:32:51 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:32:51 volumio volumio[877]: info: Dec 23 19:32:51 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:32:51 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:32:51 volumio volumio[877]: info: sendMpdCommand status took 2 milliseconds Dec 23 19:32:51 volumio volumio[877]: info: sendMpdCommand status took 0 milliseconds Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:32:51 volumio volumio[877]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 23 19:32:51 volumio volumio[877]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:32:51 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:32:51 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:32:51 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:51 volumio volumio[877]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3755,"duration":214,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"晚風 (Night Breeze)","artist":"Vincy Chan (泳兒)","album":"Fever [Mora DSF DSD128/5,6MHz]","uri":"NAS/Vmusic/1.DSD128/泳兒/泳兒 - Fever [Mora DSF DSD128 5,6MHz]/05-晚風 (Night Breeze).dsf","trackType":"dsf"} Dec 23 19:32:51 volumio volumio[877]: verbose: CURRENT POSITION 4 Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::syncState stateService pause Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus pause Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:32:51 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:32:51 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:32:51 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:51 volumio volumio[877]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3755,"duration":214,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"晚風 (Night Breeze)","artist":"Vincy Chan (泳兒)","album":"Fever [Mora DSF DSD128/5,6MHz]","uri":"NAS/Vmusic/1.DSD128/泳兒/泳兒 - Fever [Mora DSF DSD128 5,6MHz]/05-晚風 (Night Breeze).dsf","trackType":"dsf"} Dec 23 19:32:51 volumio volumio[877]: verbose: CURRENT POSITION 4 Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::syncState stateService pause Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus pause Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:32:51 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:32:51 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:32:51 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:32:51 volumio volumio[877]: info: ------------------------------ 21ms Dec 23 19:32:51 volumio volumio[877]: info: ------------------------------ 20ms Dec 23 19:32:51 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:51 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 12. Dec 23 19:32:51 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:51 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:51 volumio volumio[6491]: Traceback (most recent call last): Dec 23 19:32:51 volumio volumio[6491]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:51 volumio volumio[6491]: from aiohttp import web Dec 23 19:32:51 volumio volumio[6491]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:51 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:51 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:53 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:53 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 13. Dec 23 19:32:53 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:54 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:54 volumio volumio[6492]: Traceback (most recent call last): Dec 23 19:32:54 volumio volumio[6492]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:54 volumio volumio[6492]: from aiohttp import web Dec 23 19:32:54 volumio volumio[6492]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:56 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:56 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 14. Dec 23 19:32:56 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:56 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:56 volumio volumio[6494]: Traceback (most recent call last): Dec 23 19:32:56 volumio volumio[6494]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:56 volumio volumio[6494]: from aiohttp import web Dec 23 19:32:56 volumio volumio[6494]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:56 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:56 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:32:58 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:32:58 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 15. Dec 23 19:32:58 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:32:58 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:32:58 volumio volumio[6495]: Traceback (most recent call last): Dec 23 19:32:58 volumio volumio[6495]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:32:58 volumio volumio[6495]: from aiohttp import web Dec 23 19:32:58 volumio volumio[6495]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:32:58 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:32:58 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:00 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:00 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 16. Dec 23 19:33:00 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:00 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:00 volumio volumio[6510]: Traceback (most recent call last): Dec 23 19:33:00 volumio volumio[6510]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:00 volumio volumio[6510]: from aiohttp import web Dec 23 19:33:00 volumio volumio[6510]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:02 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:02 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 17. Dec 23 19:33:02 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:03 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:03 volumio volumio[6514]: Traceback (most recent call last): Dec 23 19:33:03 volumio volumio[6514]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:03 volumio volumio[6514]: from aiohttp import web Dec 23 19:33:03 volumio volumio[6514]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:04 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 23 19:33:04 volumio volumio[877]: info: CURURI: music-library/NAS/Vmusic/1.DSD256 Dec 23 19:33:04 volumio volumio[877]: info: Preload queue cleared Dec 23 19:33:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 18. Dec 23 19:33:05 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:05 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:05 volumio volumio[6516]: Traceback (most recent call last): Dec 23 19:33:05 volumio volumio[6516]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:05 volumio volumio[6516]: from aiohttp import web Dec 23 19:33:05 volumio volumio[6516]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 23 19:33:06 volumio volumio[877]: info: CURURI: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs) Dec 23 19:33:07 volumio volumio[877]: info: Preload queue cleared Dec 23 19:33:07 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:07 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 19. Dec 23 19:33:07 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:07 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:07 volumio volumio[6518]: Traceback (most recent call last): Dec 23 19:33:07 volumio volumio[6518]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:07 volumio volumio[6518]: from aiohttp import web Dec 23 19:33:07 volumio volumio[6518]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:09 volumio volumio[877]: info: Preload queue cleared Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::ClearQueue Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::stop Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::updateTrackBlock Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrackBlock Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::serviceStop Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 4 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::serviceStop Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::stop Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::clearPlayQueue Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::saveQueue Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushQueue Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::addQueueItems Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::addQueueItems Dec 23 19:33:09 volumio volumio[877]: info: Preload queue cleared Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushQueue Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::saveQueue Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::updateTrackBlock Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrackBlock Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPlay Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::play index 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::addQueueItems Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::addQueueItems Dec 23 19:33:09 volumio volumio[877]: info: Preload queue cleared Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/02.月神(Moon Goddess).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/02.月神(Moon Goddess).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/03.洛神宓妃(Fufei, the Goddess of the Luo River).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/03.洛神宓妃(Fufei, the Goddess of the Luo River).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/04.女魃(Nuba, the Goddess of Drought).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/04.女魃(Nuba, the Goddess of Drought).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/05.湘水祭(Lover Story of the Goddess of the Xiang River).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/05.湘水祭(Lover Story of the Goddess of the Xiang River).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/06.九幽神乐(Sunu, the Goddess of Music).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/06.九幽神乐(Sunu, the Goddess of Music).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/07.嫘祖始蚕(Leizu, the First Empress of Silk).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/07.嫘祖始蚕(Leizu, the First Empress of Silk).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/08.天降玄女(hiresyys.com The Mysterious Maids from Heaven).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/08.天降玄女(hiresyys.com The Mysterious Maids from Heaven).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/09.日御(Sun Goddess).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/09.日御(Sun Goddess).dsf Dec 23 19:33:09 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/10.昆仑瑶池会(The Celestial Gathering at Kunlun's Jade Pool).dsf Dec 23 19:33:09 volumio volumio[877]: info: Using cached record of: music-library/NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/10.昆仑瑶池会(The Celestial Gathering at Kunlun's Jade Pool).dsf Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::stop Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushQueue Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::saveQueue Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::play index undefined Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::updateTrackBlock Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrackBlock Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::startPlaybackTimer Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::clearAddPlayTracks NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand stop took 29 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand stop took 5 milliseconds Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces system playlist update Dec 23 19:33:09 volumio volumio[877]: info: Ignoring MPD Status Update Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand status took 4 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand clear took 3 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand status took 2 milliseconds Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand add "NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf" Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 19:33:09 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState stateService stop Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus stop Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: No code Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 23ms Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces system playlist update Dec 23 19:33:09 volumio volumio[877]: info: Ignoring MPD Status Update Dec 23 19:33:09 volumio volumio[877]: error: updateQueue error: null Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces system playlist update Dec 23 19:33:09 volumio volumio[877]: info: Ignoring MPD Status Update Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 26ms Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand playlistinfo took 24 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand add "NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf" took 25 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 5ms Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand play Dec 23 19:33:09 volumio volumio[877]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 33ms Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces system playlist update Dec 23 19:33:09 volumio volumio[877]: info: Ignoring MPD Status Update Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 9ms Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand play took 7 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 6ms Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:09 volumio volumio[877]: info: FusionDsp - ---- read samplerate, raw: 384000,S32_LE,2,32 Dec 23 19:33:09 volumio volumio[877]: info: FusionDsp - ---- read samplerate from file: 384000 Dec 23 19:33:09 volumio volumio[877]: error: FusionDsp - TypeError: Cannot read property 'stop' of null Dec 23 19:33:09 volumio volumio[877]: info: FusionDsp - ---- read samplerate, raw: 384000,S32_LE,2,32 Dec 23 19:33:09 volumio volumio[877]: info: FusionDsp - ---- read samplerate from file: 384000 Dec 23 19:33:09 volumio volumio[877]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand status took 20 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand status took 19 milliseconds Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:09 volumio volumio[877]: info: Dec 23 19:33:09 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand status took 4 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand status took 2 milliseconds Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":282,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"娲皇创世(Nuwa, the Empress of the Creation of Humanity)","artist":"须弥乐团,潘畅,侴婉宁,郑瑀,侯长青","album":"须弥·神曲(Sumeru·Divine Songs) (11.2MHz DSD)","uri":"NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf","trackType":"dsf"} Dec 23 19:33:09 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState stateService play Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus stop Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":282,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"娲皇创世(Nuwa, the Empress of the Creation of Humanity)","artist":"须弥乐团,潘畅,侴婉宁,郑瑀,侯长青","album":"须弥·神曲(Sumeru·Divine Songs) (11.2MHz DSD)","uri":"NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf","trackType":"dsf"} Dec 23 19:33:09 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState stateService play Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus play Dec 23 19:33:09 volumio volumio[877]: info: Received an update from plugin. extracting info from payload Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 41ms Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 48ms Dec 23 19:33:09 volumio volumio[877]: error: FusionDsp - WebSocket error: [object Object] Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 23 19:33:09 volumio volumio[877]: info: sendMpdCommand playlistinfo took 24 milliseconds Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:09 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":282,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"娲皇创世(Nuwa, the Empress of the Creation of Humanity)","artist":"须弥乐团,潘畅,侴婉宁,郑瑀,侯长青","album":"须弥·神曲(Sumeru·Divine Songs) (11.2MHz DSD)","uri":"NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf","trackType":"dsf"} Dec 23 19:33:09 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState stateService play Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus play Dec 23 19:33:09 volumio volumio[877]: info: Received an update from plugin. extracting info from payload Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":282,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"娲皇创世(Nuwa, the Empress of the Creation of Humanity)","artist":"须弥乐团,潘畅,侴婉宁,郑瑀,侯长青","album":"须弥·神曲(Sumeru·Divine Songs) (11.2MHz DSD)","uri":"NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf","trackType":"dsf"} Dec 23 19:33:09 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState stateService play Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus play Dec 23 19:33:09 volumio volumio[877]: info: Received an update from plugin. extracting info from payload Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:09 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:09 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 56ms Dec 23 19:33:09 volumio volumio[877]: info: ------------------------------ 54ms Dec 23 19:33:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 20. Dec 23 19:33:09 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:09 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:09 volumio volumio[6525]: Traceback (most recent call last): Dec 23 19:33:09 volumio volumio[6525]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:09 volumio volumio[6525]: from aiohttp import web Dec 23 19:33:09 volumio volumio[6525]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 21. Dec 23 19:33:11 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:12 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:12 volumio volumio[6535]: Traceback (most recent call last): Dec 23 19:33:12 volumio volumio[6535]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:12 volumio volumio[6535]: from aiohttp import web Dec 23 19:33:12 volumio volumio[6535]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 22. Dec 23 19:33:14 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:14 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:14 volumio volumio[6537]: Traceback (most recent call last): Dec 23 19:33:14 volumio volumio[6537]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:14 volumio volumio[6537]: from aiohttp import web Dec 23 19:33:14 volumio volumio[6537]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 23. Dec 23 19:33:16 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:16 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:16 volumio volumio[6538]: Traceback (most recent call last): Dec 23 19:33:16 volumio volumio[6538]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:16 volumio volumio[6538]: from aiohttp import web Dec 23 19:33:16 volumio volumio[6538]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::volumioPause Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::pause Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::servicePause Dec 23 19:33:16 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::servicePause Dec 23 19:33:16 volumio volumio[877]: info: ControllerMpd::pause Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand pause Dec 23 19:33:16 volumio volumio[877]: info: Dec 23 19:33:16 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:16 volumio volumio[877]: info: sendMpdCommand pause took 2 milliseconds Dec 23 19:33:16 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:16 volumio volumio[877]: info: Dec 23 19:33:16 volumio volumio[877]: ---------------------------- MPD announces state update: player Dec 23 19:33:16 volumio volumio[877]: info: ControllerMpd::getState Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status Dec 23 19:33:16 volumio volumio[877]: info: sendMpdCommand status took 2 milliseconds Dec 23 19:33:16 volumio volumio[877]: info: sendMpdCommand status took 1 milliseconds Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::parseState Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 19:33:16 volumio volumio[877]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 23 19:33:16 volumio volumio[877]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:16 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo Dec 23 19:33:16 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:16 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:16 volumio volumio[877]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":338,"duration":282,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"娲皇创世(Nuwa, the Empress of the Creation of Humanity)","artist":"须弥乐团,潘畅,侴婉宁,郑瑀,侯长青","album":"须弥·神曲(Sumeru·Divine Songs) (11.2MHz DSD)","uri":"NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf","trackType":"dsf"} Dec 23 19:33:16 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::syncState stateService pause Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus pause Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:16 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:33:16 volumio volumio[877]: info: ControllerMpd::pushState Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::servicePushState Dec 23 19:33:16 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:16 volumio volumio[877]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":338,"duration":282,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"娲皇创世(Nuwa, the Empress of the Creation of Humanity)","artist":"须弥乐团,潘畅,侴婉宁,郑瑀,侯长青","album":"须弥·神曲(Sumeru·Divine Songs) (11.2MHz DSD)","uri":"NAS/Vmusic/1.DSD256/须弥·神曲(Sumeru·Divine Songs)/01.娲皇创世(Nuwa, the Empress of the Creation of Humanity).dsf","trackType":"dsf"} Dec 23 19:33:16 volumio volumio[877]: verbose: CURRENT POSITION 0 Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::syncState stateService pause Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus pause Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::pushState Dec 23 19:33:16 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Dec 23 19:33:16 volumio volumio[877]: info: CoreCommandRouter::volumioPushState Dec 23 19:33:16 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer Dec 23 19:33:16 volumio volumio[877]: info: ------------------------------ 22ms Dec 23 19:33:16 volumio volumio[877]: info: ------------------------------ 20ms Dec 23 19:33:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 24. Dec 23 19:33:18 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:18 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:18 volumio volumio[6539]: Traceback (most recent call last): Dec 23 19:33:18 volumio volumio[6539]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:18 volumio volumio[6539]: from aiohttp import web Dec 23 19:33:18 volumio volumio[6539]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 25. Dec 23 19:33:20 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:21 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:21 volumio volumio[6554]: Traceback (most recent call last): Dec 23 19:33:21 volumio volumio[6554]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:21 volumio volumio[6554]: from aiohttp import web Dec 23 19:33:21 volumio volumio[6554]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:22 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 19:33:22 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 23 19:33:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 26. Dec 23 19:33:23 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:23 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:23 volumio volumio[6558]: Traceback (most recent call last): Dec 23 19:33:23 volumio volumio[6558]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:23 volumio volumio[6558]: from aiohttp import web Dec 23 19:33:23 volumio volumio[6558]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 27. Dec 23 19:33:25 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:25 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:25 volumio volumio[6559]: Traceback (most recent call last): Dec 23 19:33:25 volumio volumio[6559]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:25 volumio volumio[6559]: from aiohttp import web Dec 23 19:33:25 volumio volumio[6559]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:27 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:27 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 28. Dec 23 19:33:27 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:27 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:27 volumio volumio[6560]: Traceback (most recent call last): Dec 23 19:33:27 volumio volumio[6560]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:27 volumio volumio[6560]: from aiohttp import web Dec 23 19:33:27 volumio volumio[6560]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:29 volumio volumio[877]: info: Enabling plugin fusiondsp Dec 23 19:33:29 volumio volumio[877]: info: Loading plugin "fusiondsp"... Dec 23 19:33:29 volumio volumio[877]: info: Applying required configuration parameters for plugin fusiondsp Dec 23 19:33:29 volumio volumio[877]: info: Preparing to generate the ALSA configuration file Dec 23 19:33:29 volumio volumio[877]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 23 19:33:29 volumio volumio[877]: info: Reading ALSA contributions from plugins. Dec 23 19:33:29 volumio volumio[877]: info: Asound.conf file unchanged, so no further update is needed Dec 23 19:33:29 volumio volumio[877]: info: Output device has changed, restarting MPD Dec 23 19:33:29 volumio sudo[6562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 19:33:29 volumio sudo[6562]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio sudo[6562]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:29 volumio volumio[877]: info: Output device has changed, restarting Shairport Sync Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 19:33:29 volumio sudo[6565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 19:33:29 volumio sudo[6565]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio systemd[1]: Stopping Music Player Daemon... Dec 23 19:33:29 volumio volumio[877]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 19:33:29 volumio volumio[877]: info: PLUGIN START: fusiondsp Dec 23 19:33:29 volumio volumio[877]: info: Loading i18n strings for locale zh_TW Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: FusionDsp - mixtype--------------------- None Dec 23 19:33:29 volumio volumio[877]: info: Preparing to generate the ALSA configuration file Dec 23 19:33:29 volumio volumio[877]: info: Done. Dec 23 19:33:29 volumio volumio[877]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 23 19:33:29 volumio volumio[877]: info: Reading ALSA contributions from plugins. Dec 23 19:33:29 volumio volumio[877]: info: MPD Permissions set Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio systemd[1]: mpd.service: Succeeded. Dec 23 19:33:29 volumio systemd[1]: Stopped Music Player Daemon. Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: Starting Shairport Sync Dec 23 19:33:29 volumio volumio[877]: info: Asound.conf file unchanged, so no further update is needed Dec 23 19:33:29 volumio volumio[877]: info: Output device has changed, restarting MPD Dec 23 19:33:29 volumio sudo[6576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 19:33:29 volumio sudo[6576]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio systemd[1]: Starting Music Player Daemon... Dec 23 19:33:29 volumio volumio[877]: info: Output device has changed, restarting Shairport Sync Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 19:33:29 volumio sudo[6579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 19:33:29 volumio sudo[6579]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio sudo[6579]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:29 volumio sudo[6582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 19:33:29 volumio sudo[6582]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 23 19:33:29 volumio volumio[877]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 19:33:29 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 23 19:33:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 23 19:33:29 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 23 19:33:29 volumio systemd[1]: mpd.service: Succeeded. Dec 23 19:33:29 volumio systemd[1]: Stopped Music Player Daemon. Dec 23 19:33:29 volumio volumio[877]: info: MPD Permissions set Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio systemd[1]: Starting Music Player Daemon... Dec 23 19:33:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 23 19:33:29 volumio sudo[6576]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 19:33:29 volumio volumio[877]: info: Shairport-Sync Started Dec 23 19:33:29 volumio volumio[877]: info: Starting Shairport Sync Dec 23 19:33:29 volumio sudo[6596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 19:33:29 volumio sudo[6596]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio sudo[6587]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 23 19:33:29 volumio sudo[6587]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 19:33:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 23 19:33:29 volumio sudo[6587]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:29 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 23 19:33:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 23 19:33:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 23 19:33:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 29. Dec 23 19:33:29 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 23 19:33:29 volumio systemd[1]: Started FusionDsp Daemon. Dec 23 19:33:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 23 19:33:29 volumio sudo[6596]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:29 volumio volumio[877]: info: Shairport-Sync Started Dec 23 19:33:29 volumio volumio[6614]: Traceback (most recent call last): Dec 23 19:33:29 volumio volumio[6614]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 23 19:33:29 volumio volumio[6614]: from aiohttp import web Dec 23 19:33:29 volumio volumio[6614]: ModuleNotFoundError: No module named 'aiohttp' Dec 23 19:33:29 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 23 19:33:29 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 23 19:33:30 volumio mpd[6603]: Dec 23 19:33 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 23 19:33:30 volumio systemd[1]: Started Music Player Daemon. Dec 23 19:33:30 volumio sudo[6582]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:30 volumio sudo[6565]: pam_unix(sudo:session): session closed for user root Dec 23 19:33:30 volumio volumio[877]: error: MPD error: The expression evaluated to a falsy value: Dec 23 19:33:30 volumio volumio[877]: assert.ok(self.idling) Dec 23 19:33:30 volumio volumio[877]: error: The expression evaluated to a falsy value: Dec 23 19:33:30 volumio volumio[877]: assert.ok(self.idling) Dec 23 19:33:30 volumio volumio[877]: error: updateQueue error: null Dec 23 19:33:31 volumio volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 19:33:31 volumio volumio[877]: TypeError: Cannot read property 'off' of undefined Dec 23 19:33:31 volumio volumio[877]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Dec 23 19:33:31 volumio volumio[877]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Dec 23 19:33:31 volumio volumio[877]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Dec 23 19:33:31 volumio volumio[877]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Dec 23 19:33:31 volumio volumio[877]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1412:47) Dec 23 19:33:31 volumio volumio[877]: at Socket.emit (events.js:315:20) Dec 23 19:33:31 volumio volumio[877]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 23 19:33:31 volumio volumio[877]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 23 19:33:31 volumio volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 19:33:31 volumio sudo[6629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-23 19:32 Dec 23 19:33:31 volumio sudo[6629]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"