-- Logs begin at Tue 2025-06-10 04:02:32 PDT, end at Tue 2025-06-10 11:34:43 PDT. --
Jun 10 11:33:00 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:00 volumio volumio[4004]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:01 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:33:01 volumio volumio[1061]: info: CorePlayQueue::getTrack 8
Jun 10 11:33:02 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:02 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 166.
Jun 10 11:33:02 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:02 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:02 volumio volumio[4006]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:02 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:02 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:03 volumio volumio[1061]: info: Executing endpoint metavolumio
Jun 10 11:33:03 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 10 11:33:03 volumio volumio[1061]: info: Executing endpoint metavolumio
Jun 10 11:33:03 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 10 11:33:03 volumio volumio[1061]: info: Executing endpoint metavolumio
Jun 10 11:33:03 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 10 11:33:04 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:04 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 167.
Jun 10 11:33:04 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:04 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:04 volumio volumio[4007]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:04 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:04 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:06 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:06 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 168.
Jun 10 11:33:06 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:06 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:06 volumio volumio[4008]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:06 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:06 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:08 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:08 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 169.
Jun 10 11:33:08 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:09 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:09 volumio volumio[4026]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:09 volumio volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 10 11:33:09 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jun 10 11:33:09 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jun 10 11:33:09 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jun 10 11:33:09 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Jun 10 11:33:09 volumio volumio[1061]: info: Received Get System Version
Jun 10 11:33:09 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 11:33:11 volumio go-librespot[18491]: time="2025-06-10T11:33:11-07:00" level=debug msg="fetched chunk 13/14, size: 524288"
Jun 10 11:33:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 170.
Jun 10 11:33:11 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:11 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:11 volumio volumio[4042]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:11 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:11 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:13 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:13 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 171.
Jun 10 11:33:13 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:13 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:13 volumio volumio[4043]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:13 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:13 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:15 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:15 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 172.
Jun 10 11:33:15 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:15 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:15 volumio volumio[4045]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:15 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:15 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 173.
Jun 10 11:33:17 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:18 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:18 volumio volumio[4046]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 174.
Jun 10 11:33:20 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:20 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:20 volumio volumio[4065]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:20 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:20 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:21 volumio volumio[1061]: info: CorePlayQueue::getQueue
Jun 10 11:33:21 volumio volumio[1061]: info: CorePlayQueue::getTrack 8
Jun 10 11:33:21 volumio volumio[1061]: info: [1749580401461] ControllerPandora::ExpireOldTracks::reaper
Jun 10 11:33:21 volumio volumio[1061]: info: [1749580401461] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks. Don't worry -- Jason will return.
Jun 10 11:33:22 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:22 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 175.
Jun 10 11:33:22 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:22 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:22 volumio volumio[4066]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:22 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:22 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:22 volumio go-librespot[18491]: time="2025-06-10T11:33:22-07:00" level=debug msg="fetched chunk 14/14, size: 79842"
Jun 10 11:33:24 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:24 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 176.
Jun 10 11:33:24 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:24 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:24 volumio volumio[4067]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:24 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:24 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:25 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:33:25 volumio volumio[1061]: info: CorePlayQueue::getTrack 8
Jun 10 11:33:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 177.
Jun 10 11:33:26 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:27 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:27 volumio volumio[4069]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:27 volumio volumio[1061]: info: Executing endpoint metavolumio
Jun 10 11:33:27 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 10 11:33:27 volumio volumio[1061]: info: Executing endpoint metavolumio
Jun 10 11:33:27 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 10 11:33:27 volumio volumio[1061]: info: Executing endpoint metavolumio
Jun 10 11:33:27 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 10 11:33:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 178.
Jun 10 11:33:29 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:29 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:29 volumio volumio[4085]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:29 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:29 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:29 volumio volumio[1061]: error: Failed request for metavolumio API
Jun 10 11:33:31 volumio volumio[1061]: error: Failed request for metavolumio API
Jun 10 11:33:31 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:31 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 179.
Jun 10 11:33:31 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:31 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:31 volumio volumio[4086]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:31 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 10 11:33:31 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 10 11:33:31 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:31 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:33 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:33 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 180.
Jun 10 11:33:33 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:33 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:33 volumio volumio[4088]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:33 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:33 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 181.
Jun 10 11:33:35 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:36 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:36 volumio volumio[4089]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:36 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:36 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:38 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:38 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 182.
Jun 10 11:33:38 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:38 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:38 volumio volumio[4091]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:38 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:38 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:40 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:40 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 183.
Jun 10 11:33:40 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:40 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:40 volumio volumio[4109]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:40 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:40 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:42 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:42 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 184.
Jun 10 11:33:42 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:42 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:42 volumio volumio[4110]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:42 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:42 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:44 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:44 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 185.
Jun 10 11:33:44 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:45 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:45 volumio volumio[4119]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:45 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:45 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:47 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:47 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 186.
Jun 10 11:33:47 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:47 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:47 volumio volumio[4120]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:47 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:47 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:49 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:49 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 187.
Jun 10 11:33:49 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:49 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:49 volumio volumio[4136]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:49 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:49 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:51 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:51 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 188.
Jun 10 11:33:51 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:51 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:51 volumio volumio[4160]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:51 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:51 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:53 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:53 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 189.
Jun 10 11:33:53 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:54 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:54 volumio volumio[4177]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:56 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:56 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 190.
Jun 10 11:33:56 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:56 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:56 volumio volumio[4179]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:56 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:56 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:33:58 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:33:58 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 191.
Jun 10 11:33:58 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:33:58 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:33:58 volumio volumio[4180]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:33:58 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:33:58 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:00 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:00 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 192.
Jun 10 11:34:00 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:00 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:00 volumio volumio[4198]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:02 volumio volumio[1061]: info: CorePlayQueue::getTrack 8
Jun 10 11:34:02 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:02 volumio volumio[1061]: info: Prefetching next song
Jun 10 11:34:02 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:02 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 193.
Jun 10 11:34:02 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:03 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:03 volumio volumio[4200]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:03 volumio go-librespot[18491]: time="2025-06-10T11:34:03-07:00" level=trace msg="emitting websocket event: not_playing"
Jun 10 11:34:03 volumio go-librespot[18491]: time="2025-06-10T11:34:03-07:00" level=debug msg="loading track spotify:track:1zWBm3xGnoNOpo9Pclpgk1 (paused: true, position: 0ms)"
Jun 10 11:34:03 volumio volumio[1061]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:1zWBm3xGnoNOpo9Pclpgk1","play_origin":"go-librespot"}}
Jun 10 11:34:03 volumio volumio[1061]: error: Failed to decode event: not_playing
Jun 10 11:34:03 volumio go-librespot[18491]: time="2025-06-10T11:34:03-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jun 10 11:34:03 volumio go-librespot[18491]: time="2025-06-10T11:34:03-07:00" level=trace msg="emitting websocket event: will_play"
Jun 10 11:34:03 volumio volumio[1061]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1zWBm3xGnoNOpo9Pclpgk1","play_origin":"go-librespot"}}
Jun 10 11:34:03 volumio go-librespot[18491]: time="2025-06-10T11:34:03-07:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:1zWBm3xGnoNOpo9Pclpgk1"
Jun 10 11:34:03 volumio go-librespot[18491]: time="2025-06-10T11:34:03-07:00" level=debug msg="requested aes key for file 69b78dee3e95d8b7417fba74b6fd1bc703a49396, gid: 1zWBm3xGnoNOpo9Pclpgk1"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="fetched first chunk of 15, total size is 7419874 bytes"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=info msg="loaded track \"Blame Brett\" (uri: spotify:track:1zWBm3xGnoNOpo9Pclpgk1, paused: true, position: 0ms, duration: 177003ms)"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="emitting websocket event: metadata"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="emitting websocket event: stopped"
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1zWBm3xGnoNOpo9Pclpgk1","name":"Blame Brett","artist_names":["The Beaches"],"album_name":"Blame Jocelyn","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02fb221471c457c7721e985600","position":0,"duration":177003,"release_date":"year:2024 month:6 day:1","track_number":2,"disc_number":1}}
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}}
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: PUSH STATE SPOTIFY
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: {"status":"stop","service":"spop","title":"Blame Brett","artist":"The Beaches","album":"Blame Jocelyn","albumart":"https://i.scdn.co/image/ab67616d00001e02fb221471c457c7721e985600","uri":"spotify:track:1zWBm3xGnoNOpo9Pclpgk1","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::servicePushState
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::pushState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 8
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioPushState
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="fetched chunk 1/14, size: 524288"
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output update for this device
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 8
Jun 10 11:34:04 volumio volumio[1061]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Blame Brett","artist":"The Beaches","album":"Blame Jocelyn","albumart":"https://i.scdn.co/image/ab67616d00001e02fb221471c457c7721e985600","uri":"spotify:track:1zWBm3xGnoNOpo9Pclpgk1","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:04 volumio volumio[1061]: verbose: CURRENT POSITION 8
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::syncState stateService stop
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::syncState currentStatus play
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::play index undefined
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::pushState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioPushState
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output update for this device
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::startPlaybackTimer
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: info: [1749580444340] ControllerSpotify::clearAddPlayTrack
Jun 10 11:34:04 volumio volumio[1061]: info: Sending Spotify command with payload to local API: /player/play
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::pushState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioPushState
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output update for this device
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="fetched chunk 2/14, size: 524288"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="fetched chunk 3/14, size: 524288"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="emitting websocket event: paused"
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:1zWBm3xGnoNOpo9Pclpgk1","play_origin":"go-librespot"}}
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: PUSH STATE SPOTIFY
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: {"status":"pause","service":"spop","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"spotify","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::servicePushState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"spotify","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:04 volumio volumio[1061]: verbose: CURRENT POSITION 9
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::syncState stateService pause
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::syncState currentStatus stop
Jun 10 11:34:04 volumio volumio[1061]: info: CoreStateMachine::pushState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioPushState
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output update for this device
Jun 10 11:34:04 volumio volumio[1061]: info: MRS: Pushing multiroomSync output
Jun 10 11:34:04 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:04 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="fetched new page 0 with 1 items (list: 1)"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="loading track spotify:track:4cOdK2wGLETKBW3PvgPWqT (paused: false, position: 0ms)"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="emitting websocket event: will_play"
Jun 10 11:34:04 volumio volumio[1061]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","play_origin":"go-librespot"}}
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:4cOdK2wGLETKBW3PvgPWqT"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="requested aes key for file 5182bea01744133d7c58ad7f0360c6f7891f94d6, gid: 4cOdK2wGLETKBW3PvgPWqT"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=debug msg="fetched first chunk of 18, total size is 8947560 bytes"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)"
Jun 10 11:34:04 volumio go-librespot[18491]: time="2025-06-10T11:34:04-07:00" level=info msg="loaded track \"Never Gonna Give You Up\" (uri: spotify:track:4cOdK2wGLETKBW3PvgPWqT, paused: false, position: 0ms, duration: 213573ms)"
Jun 10 11:34:04 volumio go-librespot[18491]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:912:(_snd_pcm_volumioswitch_advance) PCM volumioMultiRoomServer cannot write to target PCM softvolume as it has failed its update check.
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=trace msg="emitting websocket event: metadata"
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","name":"Never Gonna Give You Up","artist_names":["Rick Astley"],"album_name":"Whenever You Need Somebody","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02baf89eb11ec7c657805d2da0","position":0,"duration":213573,"release_date":"year:1987 month:11 day:12","track_number":1,"disc_number":1}}
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=debug msg="fetched chunk 1/17, size: 524288"
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=debug msg="fetched chunk 3/17, size: 524288"
Jun 10 11:34:05 volumio go-librespot[18491]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:912:(_snd_pcm_volumioswitch_advance) PCM volumioMultiRoomServer cannot write to target PCM softvolume as it has failed its update check.
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=trace msg="emitting websocket event: playing"
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","play_origin":"go-librespot"}}
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: PUSH STATE SPOTIFY
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: {"status":"play","service":"spop","title":"Never Gonna Give You Up","artist":"Rick Astley","album":"Whenever You Need Somebody","albumart":"https://i.scdn.co/image/ab67616d00001e02baf89eb11ec7c657805d2da0","uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","trackType":"spotify","seek":0,"duration":213,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::servicePushState
Jun 10 11:34:05 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:05 volumio volumio[1061]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Never Gonna Give You Up","artist":"Rick Astley","album":"Whenever You Need Somebody","albumart":"https://i.scdn.co/image/ab67616d00001e02baf89eb11ec7c657805d2da0","uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","trackType":"spotify","seek":0,"duration":213,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:05 volumio volumio[1061]: verbose: CURRENT POSITION 9
Jun 10 11:34:05 volumio volumio[1061]: info: CoreStateMachine::syncState stateService play
Jun 10 11:34:05 volumio volumio[1061]: info: CoreStateMachine::syncState currentStatus stop
Jun 10 11:34:05 volumio go-librespot[18491]: time="2025-06-10T11:34:05-07:00" level=debug msg="fetched chunk 2/17, size: 524288"
Jun 10 11:34:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 194.
Jun 10 11:34:05 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:05 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: PUSH STATE SPOTIFY
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: {"status":"play","service":"spop","title":"Never Gonna Give You Up","artist":"Rick Astley","album":"Whenever You Need Somebody","albumart":"https://i.scdn.co/image/ab67616d00001e02baf89eb11ec7c657805d2da0","uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","trackType":"spotify","seek":0,"duration":213,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::servicePushState
Jun 10 11:34:05 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:05 volumio volumio[1061]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Never Gonna Give You Up","artist":"Rick Astley","album":"Whenever You Need Somebody","albumart":"https://i.scdn.co/image/ab67616d00001e02baf89eb11ec7c657805d2da0","uri":"spotify:track:4cOdK2wGLETKBW3PvgPWqT","trackType":"spotify","seek":0,"duration":213,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jun 10 11:34:05 volumio volumio[1061]: verbose: CURRENT POSITION 9
Jun 10 11:34:05 volumio volumio[1061]: info: CoreStateMachine::syncState stateService play
Jun 10 11:34:05 volumio volumio[1061]: info: CoreStateMachine::syncState currentStatus play
Jun 10 11:34:05 volumio volumio[1061]: info: Received an update from plugin. extracting info from payload
Jun 10 11:34:05 volumio volumio[1061]: info: CoreStateMachine::pushState
Jun 10 11:34:05 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::volumioPushState
Jun 10 11:34:05 volumio volumio[1061]: info: MRS: Pushing multiroomSync output update for this device
Jun 10 11:34:05 volumio volumio[4201]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:05 volumio volumio[1061]: info: MRS: Pushing multiroomSync output
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:05 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:05 volumio volumio[1061]: info: CoreStateMachine::pushState
Jun 10 11:34:05 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::volumioPushState
Jun 10 11:34:05 volumio volumio[1061]: info: MRS: Pushing multiroomSync output update for this device
Jun 10 11:34:05 volumio volumio[1061]: info: MRS: Pushing multiroomSync output
Jun 10 11:34:05 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:05 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24
Jun 10 11:34:05 volumio volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24
Jun 10 11:34:07 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:07 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 195.
Jun 10 11:34:07 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:07 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:07 volumio volumio[4202]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 196.
Jun 10 11:34:09 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:09 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:09 volumio volumio[4219]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:11 volumio go-librespot[18491]: time="2025-06-10T11:34:11-07:00" level=debug msg="fetched chunk 4/17, size: 524288"
Jun 10 11:34:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 197.
Jun 10 11:34:11 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:12 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:12 volumio volumio[4220]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:13 volumio volumio[1061]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Jun 10 11:34:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 198.
Jun 10 11:34:14 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:14 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:14 volumio volumio[4224]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:16 volumio volumio[1061]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Jun 10 11:34:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 199.
Jun 10 11:34:16 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:16 volumio volumio[1061]: info: Check plugin dependencies
Jun 10 11:34:16 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:16 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 11:34:16 volumio volumio[1061]: info: Rename folder
Jun 10 11:34:16 volumio volumio[4227]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:16 volumio volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed
Jun 10 11:34:16 volumio volumio[1061]: info: Move to category
Jun 10 11:34:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:17 volumio volumio[1061]: info: Checking if install.sh is present
Jun 10 11:34:17 volumio volumio[1061]: info: Executing install.sh
Jun 10 11:34:17 volumio sudo[4238]: pam_unix(sudo:auth): authentication failure; logname= uid=1000 euid=0 tty= ruser=volumio rhost= user=volumio
Jun 10 11:34:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 200.
Jun 10 11:34:18 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:18 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:18 volumio volumio[4239]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:20 volumio sudo[4238]: pam_unix(sudo:auth): conversation failed
Jun 10 11:34:20 volumio sudo[4238]: pam_unix(sudo:auth): auth could not identify password for [volumio]
Jun 10 11:34:20 volumio sudo[4238]: volumio : 1 incorrect password attempt ; TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh
Jun 10 11:34:20 volumio volumio[1061]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/audio_interface/fusiondsp/install.sh > /tmp/installog
Jun 10 11:34:20 volumio volumio[1061]: [sudo] password for volumio: Sorry, try again.
Jun 10 11:34:20 volumio volumio[1061]: [sudo] password for volumio:
Jun 10 11:34:20 volumio volumio[1061]: sudo: no password was provided
Jun 10 11:34:20 volumio volumio[1061]: sudo: 1 incorrect password attempt
Jun 10 11:34:20 volumio volumio[1061]: info: An error occurred installing the plugin. Rolling back config
Jun 10 11:34:20 volumio volumio[1061]: info: Plugin folders cleanup
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning into folder /volumio/app/plugins/
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category audio_interface
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category miscellanea
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category music_service
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category plugins.json
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category system_controller
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category user_interface
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning into folder /data/plugins/
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category audio_interface
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category music_service
Jun 10 11:34:20 volumio volumio[1061]: info: Scanning category user_interface
Jun 10 11:34:20 volumio volumio[1061]: info: Plugin folders cleanup completed
Jun 10 11:34:20 volumio volumio[1061]: info: Error: Error
Jun 10 11:34:20 volumio volumio[1061]: info: Error: Error
Jun 10 11:34:20 volumio volumio[1061]: info: Folder /tmp/plugins removed
Jun 10 11:34:20 volumio volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed
Jun 10 11:34:20 volumio volumio[1061]: info: Folder /data/temp removed
Jun 10 11:34:20 volumio exim[4260]: 2025-06-10 11:34:20 1uP3ng-00016i-7F <= volumio@volumio U=volumio P=local S=548
Jun 10 11:34:20 volumio exim[4260]: 2025-06-10 11:34:20 1uP3ng-00016i-7F Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124
Jun 10 11:34:20 volumio exim[4260]: exim: could not open panic log - aborting: see message(s) above
Jun 10 11:34:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 201.
Jun 10 11:34:20 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:21 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:21 volumio volumio[4261]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 202.
Jun 10 11:34:23 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:23 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:23 volumio volumio[4262]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:24 volumio go-librespot[18491]: time="2025-06-10T11:34:24-07:00" level=debug msg="fetched chunk 5/17, size: 524288"
Jun 10 11:34:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 203.
Jun 10 11:34:25 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:25 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:25 volumio volumio[4263]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:27 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:27 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 204.
Jun 10 11:34:27 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:27 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:27 volumio volumio[4265]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:29 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 10 11:34:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 205.
Jun 10 11:34:29 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:30 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:30 volumio volumio[4281]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 206.
Jun 10 11:34:32 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:32 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:32 volumio volumio[4283]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:32 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:32 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:34 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:34 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 207.
Jun 10 11:34:34 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:34 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:34 volumio volumio[4284]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:34 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:34 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:36 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:36 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 208.
Jun 10 11:34:36 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:36 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:36 volumio go-librespot[18491]: time="2025-06-10T11:34:36-07:00" level=debug msg="fetched chunk 6/17, size: 524288"
Jun 10 11:34:36 volumio volumio[4285]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:36 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:36 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:38 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:38 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 209.
Jun 10 11:34:38 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:39 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:39 volumio volumio[4302]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:39 volumio volumio[1061]: info: Enabling plugin fusiondsp
Jun 10 11:34:39 volumio volumio[1061]: info: Loading plugin "fusiondsp"...
Jun 10 11:34:39 volumio volumio[1061]: info: Applying required configuration parameters for plugin fusiondsp
Jun 10 11:34:39 volumio volumio[1061]: info: Preparing to generate the ALSA configuration file
Jun 10 11:34:39 volumio volumio[1061]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 10 11:34:39 volumio volumio[1061]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jun 10 11:34:39 volumio volumio[1061]: info: Reading ALSA contributions from plugins.
Jun 10 11:34:39 volumio volumio[1061]: info: Asound.conf file unchanged, so no further update is needed
Jun 10 11:34:39 volumio volumio[1061]: info: Output device has changed, restarting MPD
Jun 10 11:34:39 volumio sudo[4304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 10 11:34:39 volumio sudo[4304]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:39 volumio volumio[1061]: info: Output device has changed, restarting Shairport Sync
Jun 10 11:34:39 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:39 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 11:34:39 volumio sudo[4304]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:39 volumio sudo[4307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 10 11:34:39 volumio sudo[4307]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:39 volumio systemd[1]: Stopping Music Player Daemon...
Jun 10 11:34:39 volumio systemd[1]: mpd.service: Succeeded.
Jun 10 11:34:39 volumio systemd[1]: Stopped Music Player Daemon.
Jun 10 11:34:39 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:39 volumio volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 11:34:39 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:39 volumio volumio[1061]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jun 10 11:34:39 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:39 volumio systemd[1]: Starting Music Player Daemon...
Jun 10 11:34:39 volumio volumio[1061]: info: QobuzConnect: setDeactiveState invoked
Jun 10 11:34:39 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:39 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:39 volumio vtcs[1621]: [2025-06-10 11:34:39.893] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
Jun 10 11:34:39 volumio vtcs[1621]: [2025-06-10 11:34:39.894] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Jun 10 11:34:39 volumio volumio[1061]: info: PLUGIN START: fusiondsp
Jun 10 11:34:39 volumio volumio[1061]: info: Loading i18n strings for locale en
Jun 10 11:34:39 volumio sudo[4316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jun 10 11:34:39 volumio sudo[4316]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:39 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jun 10 11:34:39 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:39 volumio volumio[1061]: info: FusionDsp - mixtype--------------------- Software
Jun 10 11:34:39 volumio volumio[1061]: info: Preparing to generate the ALSA configuration file
Jun 10 11:34:39 volumio systemd[1]: Stopping Volumio Tidal Connect Service...
Jun 10 11:34:39 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Jun 10 11:34:39 volumio systemd[1]: vtcs.service: Succeeded.
Jun 10 11:34:39 volumio systemd[1]: Stopped Volumio Tidal Connect Service.
Jun 10 11:34:39 volumio sudo[4316]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:40 volumio volumio[1061]: info: Done.
Jun 10 11:34:40 volumio sudo[4312]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 10 11:34:40 volumio sudo[4312]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:40 volumio sudo[4312]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:40 volumio sudo[4324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jun 10 11:34:40 volumio sudo[4324]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:40 volumio sudo[4324]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:40 volumio volumio[1061]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 10 11:34:40 volumio volumio[1061]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jun 10 11:34:40 volumio volumio[1061]: info: Reading ALSA contributions from plugins.
Jun 10 11:34:40 volumio sudo[4331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jun 10 11:34:40 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:40 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jun 10 11:34:40 volumio sudo[4331]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:40 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:40 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 10 11:34:40 volumio sudo[4331]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:40 volumio volumio[1061]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Jun 10 11:34:40 volumio volumio[1061]: info: MPD Permissions set
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio sudo[4333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jun 10 11:34:40 volumio sudo[4333]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:40 volumio systemd[1]: Stopping Volumio Qobuz Connect Service...
Jun 10 11:34:40 volumio qobuz-connect[1573]: 20250610 11:34:40.249 [1573.1573] INFO SampleApp: Stopping Local configuration server
Jun 10 11:34:40 volumio qobuz-connect[1573]: 20250610 11:34:40.259 [1573.1573] INFO SampleApp: shat down connection on UNIX socket
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:40 volumio systemd[1]: qobuz-connect.service: Succeeded.
Jun 10 11:34:40 volumio systemd[1]: Stopped Volumio Qobuz Connect Service.
Jun 10 11:34:40 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:40 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jun 10 11:34:40 volumio volumio[1061]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jun 10 11:34:40 volumio volumio[1061]: info: QobuzConnect: setDeactiveState invoked
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:40 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:40 volumio volumio[1061]: info: FusionDsp - IP adress is ---------------------------10.0.0.13
Jun 10 11:34:40 volumio volumio[1061]: info: FusionDsp -
Jun 10 11:34:40 volumio systemd[1]: Started Volumio Qobuz Connect Service.
Jun 10 11:34:40 volumio sudo[4333]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:40 volumio volumio[1061]: info: FusionDsp - undefined
Jun 10 11:34:40 volumio volumio[1061]: info: Starting Shairport Sync
Jun 10 11:34:40 volumio sudo[4343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 10 11:34:40 volumio sudo[4343]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:40 volumio volumio[1061]: info: Executing endpoint qc_getconfig
Jun 10 11:34:40 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.950 [4339.4339] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.957 [4339.4339] INFO VolumeManager: [0xa64a38]: Setting new playback volume: 75
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.957 [4339.4339] INFO VolumeManager: [0xa64a38]: Setting new mute state: 0
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.957 [4339.4339] INFO QobuzConnect: [0xa65408]: Client initialized!
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.957 [4339.4339] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Jun 10 11:34:40 volumio volumio[1061]: info: Asound.conf file unchanged, so no further update is needed
Jun 10 11:34:40 volumio volumio[1061]: info: Output device has changed, restarting MPD
Jun 10 11:34:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 10 11:34:40 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 10 11:34:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.992 [4339.4339] INFO LocalConfigManager: [0xa64318]: Starting Local Configuration server
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.992 [4339.4339] INFO SampleApp: Starting Local configuration server
Jun 10 11:34:40 volumio qobuz-connect[4339]: 20250610 11:34:40.993 [4339.4339] INFO SampleApp: Connected to UNIX socket client 0xa59f60
Jun 10 11:34:41 volumio sudo[4348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 10 11:34:41 volumio volumio[1061]: info: Output device has changed, restarting Shairport Sync
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 11:34:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 10 11:34:41 volumio sudo[4348]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio sudo[4348]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio sudo[4343]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio sudo[4350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 10 11:34:41 volumio sudo[4350]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio qobuz-connect[4339]: 20250610 11:34:41.103 [4339.4339] INFO SampleApp: Playback volume changed: 75
Jun 10 11:34:41 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 10 11:34:41 volumio systemd[1]: mpd.service: Succeeded.
Jun 10 11:34:41 volumio systemd[1]: Stopped Music Player Daemon.
Jun 10 11:34:41 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:41 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 210.
Jun 10 11:34:41 volumio systemd[1]: Stopped FusionDsp Daemon.
Jun 10 11:34:41 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:41 volumio volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 11:34:41 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:41 volumio volumio[1061]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: QobuzConnect: setDeactiveState invoked
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:41 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:41 volumio systemd[1]: Started FusionDsp Daemon.
Jun 10 11:34:41 volumio volumio[1061]: info: Preparing to generate the ALSA configuration file
Jun 10 11:34:41 volumio systemd[1]: Starting Music Player Daemon...
Jun 10 11:34:41 volumio sudo[4363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jun 10 11:34:41 volumio sudo[4363]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio sudo[4363]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio volumio[4357]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Jun 10 11:34:41 volumio sudo[4366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jun 10 11:34:41 volumio sudo[4366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Jun 10 11:34:41 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 10 11:34:41 volumio sudo[4366]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio sudo[4362]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 10 11:34:41 volumio sudo[4362]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio sudo[4362]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio volumio[1061]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jun 10 11:34:41 volumio volumio[1061]: info: QobuzConnect: QOBUZ Connect daemon connected
Jun 10 11:34:41 volumio volumio[1061]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 10 11:34:41 volumio volumio[1061]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jun 10 11:34:41 volumio volumio[1061]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 10 11:34:41 volumio volumio[1061]: info: Reading ALSA contributions from plugins.
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:41 volumio sudo[4374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:41 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:41 volumio sudo[4374]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio volumio[1061]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Jun 10 11:34:41 volumio volumio[1061]: info: MPD Permissions set
Jun 10 11:34:41 volumio volumio[1061]: info: Shairport-Sync Started
Jun 10 11:34:41 volumio sudo[4374]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio sudo[4378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jun 10 11:34:41 volumio sudo[4378]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio systemd[1]: Stopping Volumio Qobuz Connect Service...
Jun 10 11:34:41 volumio qobuz-connect[4339]: 20250610 11:34:41.539 [4339.4339] INFO SampleApp: Stopping Local configuration server
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:41 volumio qobuz-connect[4339]: 20250610 11:34:41.549 [4339.4339] INFO SampleApp: shat down connection on UNIX socket
Jun 10 11:34:41 volumio systemd[1]: qobuz-connect.service: Succeeded.
Jun 10 11:34:41 volumio systemd[1]: Stopped Volumio Qobuz Connect Service.
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 10 11:34:41 volumio volumio[1061]: info: FusionDsp - IP adress is ---------------------------10.0.0.13
Jun 10 11:34:41 volumio volumio[1061]: info: FusionDsp -
Jun 10 11:34:41 volumio systemd[1]: Started Volumio Qobuz Connect Service.
Jun 10 11:34:41 volumio sudo[4378]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:41 volumio volumio[1061]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jun 10 11:34:41 volumio volumio[1061]: info: QobuzConnect: setDeactiveState invoked
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:41 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:41 volumio volumio[1061]: info: Starting Shairport Sync
Jun 10 11:34:41 volumio volumio[1061]: info: FusionDsp - undefined
Jun 10 11:34:41 volumio sudo[4387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 10 11:34:41 volumio sudo[4387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio volumio[1061]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jun 10 11:34:41 volumio volumio[1061]: info: Executing endpoint qc_getconfig
Jun 10 11:34:41 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jun 10 11:34:41 volumio volumio[1061]: info: Asound.conf file written
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.917 [4384.4384] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jun 10 11:34:41 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 10 11:34:41 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 10 11:34:41 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.944 [4384.4384] INFO VolumeManager: [0x1be0a38]: Setting new playback volume: 75
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.944 [4384.4384] INFO VolumeManager: [0x1be0a38]: Setting new mute state: 0
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.944 [4384.4384] INFO QobuzConnect: [0x1be1408]: Client initialized!
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.944 [4384.4384] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.968 [4384.4384] INFO LocalConfigManager: [0x1be0318]: Starting Local Configuration server
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.968 [4384.4384] INFO SampleApp: Starting Local configuration server
Jun 10 11:34:41 volumio qobuz-connect[4384]: 20250610 11:34:41.968 [4384.4384] INFO SampleApp: Connected to UNIX socket client 0x1bd5f60
Jun 10 11:34:41 volumio sudo[4391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jun 10 11:34:41 volumio sudo[4391]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 10 11:34:41 volumio sudo[4391]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio sudo[4387]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio qobuz-connect[4384]: 20250610 11:34:42.059 [4384.4384] INFO SampleApp: Playback volume changed: 75
Jun 10 11:34:42 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:42 volumio volumio[1061]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy
Jun 10 11:34:42 volumio volumio[1061]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy
Jun 10 11:34:42 volumio volumio[1061]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy
Jun 10 11:34:42 volumio volumio[1061]: info: Output device has changed, restarting MPD
Jun 10 11:34:42 volumio sudo[4399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 10 11:34:42 volumio sudo[4399]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio sudo[4399]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio volumio[1061]: info: Output device has changed, restarting Shairport Sync
Jun 10 11:34:42 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:42 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 11:34:42 volumio sudo[4402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 10 11:34:42 volumio sudo[4402]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 10 11:34:42 volumio systemd[1]: mpd.service: Succeeded.
Jun 10 11:34:42 volumio systemd[1]: Stopped Music Player Daemon.
Jun 10 11:34:42 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:42 volumio volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 11:34:42 volumio volumio[1061]: xcb_connection_has_error() returned true
Jun 10 11:34:42 volumio volumio[1061]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jun 10 11:34:42 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:42 volumio systemd[1]: Starting Music Player Daemon...
Jun 10 11:34:42 volumio volumio[1061]: info: QobuzConnect: setDeactiveState invoked
Jun 10 11:34:42 volumio volumio[1061]: info: CoreCommandRouter::volumioGetState
Jun 10 11:34:42 volumio volumio[1061]: info: CorePlayQueue::getTrack 9
Jun 10 11:34:42 volumio sudo[4411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jun 10 11:34:42 volumio sudo[4411]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio sudo[4414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jun 10 11:34:42 volumio sudo[4414]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio sudo[4407]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 10 11:34:42 volumio sudo[4407]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio sudo[4407]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio sudo[4411]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio sudo[4423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jun 10 11:34:42 volumio sudo[4423]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio sudo[4414]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio sudo[4423]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio sudo[4432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jun 10 11:34:42 volumio sudo[4432]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio volumio[1061]: info: camilladsp service started and running in background, instance 1
Jun 10 11:34:42 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 11:34:42 volumio systemd[1]: Stopping Volumio Qobuz Connect Service...
Jun 10 11:34:42 volumio qobuz-connect[4384]: 20250610 11:34:42.575 [4384.4384] INFO SampleApp: Stopping Local configuration server
Jun 10 11:34:42 volumio qobuz-connect[4384]: 20250610 11:34:42.585 [4384.4384] INFO SampleApp: shat down connection on UNIX socket
Jun 10 11:34:42 volumio systemd[1]: qobuz-connect.service: Succeeded.
Jun 10 11:34:42 volumio volumio[1061]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 10 11:34:42 volumio volumio[1061]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Jun 10 11:34:42 volumio volumio[1061]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 10 11:34:42 volumio systemd[1]: Stopped Volumio Qobuz Connect Service.
Jun 10 11:34:42 volumio volumio[1061]: info: FusionDsp loaded
Jun 10 11:34:42 volumio volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 11:34:42 volumio sudo[4439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jun 10 11:34:42 volumio sudo[4439]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:42 volumio volumio[1061]: info: FusionDsp - Reporting Fusion DSP Enabled
Jun 10 11:34:42 volumio volumio[1061]: info: Adding Signal Path Element [object Object]
Jun 10 11:34:42 volumio volumio[1061]: info: Adding fusiondspeq DSP Signal Path Element
Jun 10 11:34:42 volumio volumio[1061]: info: FusionDsp - ---- installed callbackRead
Jun 10 11:34:42 volumio volumio[1061]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 10 11:34:42 volumio systemd[1]: Started Volumio Qobuz Connect Service.
Jun 10 11:34:42 volumio sudo[4432]: pam_unix(sudo:session): session closed for user root
Jun 10 11:34:42 volumio volumio[1061]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jun 10 11:34:42 volumio volumio[1061]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jun 10 11:34:42 volumio volumio[1061]: at onErrorNT (internal/child_process.js:465:16)
Jun 10 11:34:42 volumio volumio[1061]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Jun 10 11:34:42 volumio volumio[1061]: at runNextTicks (internal/process/task_queues.js:62:3)
Jun 10 11:34:42 volumio volumio[1061]: at listOnTimeout (internal/timers.js:523:9)
Jun 10 11:34:42 volumio volumio[1061]: at processTimers (internal/timers.js:497:7) {
Jun 10 11:34:42 volumio volumio[1061]: errno: -2,
Jun 10 11:34:42 volumio volumio[1061]: code: 'ENOENT',
Jun 10 11:34:42 volumio volumio[1061]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 10 11:34:42 volumio volumio[1061]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 10 11:34:42 volumio volumio[1061]: spawnargs: [
Jun 10 11:34:42 volumio volumio[1061]: '-p',
Jun 10 11:34:42 volumio volumio[1061]: 9876,
Jun 10 11:34:42 volumio volumio[1061]: '-o',
Jun 10 11:34:42 volumio volumio[1061]: '/tmp/camilladsp.log',
Jun 10 11:34:42 volumio volumio[1061]: '-l',
Jun 10 11:34:42 volumio volumio[1061]: 'warn',
Jun 10 11:34:42 volumio volumio[1061]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jun 10 11:34:42 volumio volumio[1061]: ]
Jun 10 11:34:42 volumio volumio[1061]: }
Jun 10 11:34:42 volumio volumio[1061]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 10 11:34:43 volumio sudo[4451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-10 11:33
Jun 10 11:34:43 volumio sudo[4451]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 11:34:43 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 10 11:34:43 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 211.
Jun 10 11:34:43 volumio systemd[1]: Stopped FusionDsp Daemon.
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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"