-- Logs begin at Tue 2024-10-29 17:57:21 EET, end at Tue 2024-10-29 19:48:57 EET. -- Oct 29 19:47:00 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:00 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9729. Oct 29 19:47:00 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:00 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:00 volumio volumio[12545]: Traceback (most recent call last): Oct 29 19:47:00 volumio volumio[12545]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:00 volumio volumio[12545]: from aiohttp import web Oct 29 19:47:00 volumio volumio[12545]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:02 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:02 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9730. Oct 29 19:47:02 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:02 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:03 volumio volumio[12546]: Traceback (most recent call last): Oct 29 19:47:03 volumio volumio[12546]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:03 volumio volumio[12546]: from aiohttp import web Oct 29 19:47:03 volumio volumio[12546]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:03 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:03 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:03 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:03 volumio volumio[960]: info: CoreStateMachine::setRandom false Oct 29 19:47:03 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:03 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:03 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:03 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:03 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:03 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:03 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9731. Oct 29 19:47:05 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:05 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:05 volumio volumio[12548]: Traceback (most recent call last): Oct 29 19:47:05 volumio volumio[12548]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:05 volumio volumio[12548]: from aiohttp import web Oct 29 19:47:05 volumio volumio[12548]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:05 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:05 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:05 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:05 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:05 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:05 volumio volumio[960]: info: CoreStateMachine::setRandom true Oct 29 19:47:05 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:05 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:05 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:05 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:05 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:05 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:05 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:07 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:07 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9732. Oct 29 19:47:07 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:07 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:07 volumio volumio[12549]: Traceback (most recent call last): Oct 29 19:47:07 volumio volumio[12549]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:07 volumio volumio[12549]: from aiohttp import web Oct 29 19:47:07 volumio volumio[12549]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:08 volumio sudo[12551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 19:47:08 volumio sudo[12551]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:08 volumio sudo[12551]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:08 volumio sudo[12553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 19:47:08 volumio sudo[12553]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:09 volumio sudo[12553]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:09 volumio volumio[960]: verbose: New Socket.io Connection to 192.168.50.60 from 192.168.50.107 UA: Mozilla/5.0 (Linux; Android 11; Mi 9T Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 29 19:47:09 volumio sudo[12557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 19:47:09 volumio sudo[12557]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:09 volumio sudo[12557]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:09 volumio sudo[12559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 19:47:09 volumio sudo[12559]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:09 volumio sudo[12559]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:09 volumio volumio[960]: verbose: New Socket.io Connection to 192.168.50.60 from 192.168.50.107 UA: Mozilla/5.0 (Linux; Android 11; Mi 9T Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 29 19:47:09 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:09 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 29 19:47:09 volumio volumio[960]: info: Listing playlists Oct 29 19:47:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 19:47:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 19:47:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 19:47:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:47:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9733. Oct 29 19:47:09 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:09 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:09 volumio volumio[12562]: Traceback (most recent call last): Oct 29 19:47:09 volumio volumio[12562]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:09 volumio volumio[12562]: from aiohttp import web Oct 29 19:47:09 volumio volumio[12562]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:47:10 volumio volumio[960]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 29 19:47:10 volumio volumio[960]: info: Received Get System Version Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 19:47:10 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:10 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:10 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 19:47:11 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:11 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:11 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:11 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:11 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:11 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:11 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9734. Oct 29 19:47:11 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:11 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:12 volumio volumio[12563]: Traceback (most recent call last): Oct 29 19:47:12 volumio volumio[12563]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:12 volumio volumio[12563]: from aiohttp import web Oct 29 19:47:12 volumio volumio[12563]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:13 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 19:47:13 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:13 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:13 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:13 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:13 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:13 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:13 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9735. Oct 29 19:47:14 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:14 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:14 volumio volumio[12564]: Traceback (most recent call last): Oct 29 19:47:14 volumio volumio[12564]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:14 volumio volumio[12564]: from aiohttp import web Oct 29 19:47:14 volumio volumio[12564]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:15 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:15 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:15 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:15 volumio volumio[960]: info: CoreStateMachine::setRandom false Oct 29 19:47:15 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:15 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:15 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:15 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:15 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:15 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:15 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9736. Oct 29 19:47:16 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:16 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:16 volumio volumio[12565]: Traceback (most recent call last): Oct 29 19:47:16 volumio volumio[12565]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:16 volumio volumio[12565]: from aiohttp import web Oct 29 19:47:16 volumio volumio[12565]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:17 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:17 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:17 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:17 volumio volumio[960]: info: CoreStateMachine::setRandom true Oct 29 19:47:17 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:17 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:17 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:17 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:17 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:17 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:17 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:18 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:18 volumio volumio[960]: info: CoreStateMachine::setRandom false Oct 29 19:47:18 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:18 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:18 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:18 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:18 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:18 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9737. Oct 29 19:47:18 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:18 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:18 volumio volumio[12567]: Traceback (most recent call last): Oct 29 19:47:18 volumio volumio[12567]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:18 volumio volumio[12567]: from aiohttp import web Oct 29 19:47:18 volumio volumio[12567]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:19 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:19 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:19 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:19 volumio volumio[960]: info: CoreStateMachine::setRandom true Oct 29 19:47:19 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:19 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:19 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:19 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:19 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:19 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:19 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:20 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:20 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:20 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:20 volumio volumio[960]: info: CoreStateMachine::setRandom false Oct 29 19:47:20 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:20 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:20 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:20 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:20 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:20 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:20 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9738. Oct 29 19:47:20 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:20 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:21 volumio volumio[12568]: Traceback (most recent call last): Oct 29 19:47:21 volumio volumio[12568]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:21 volumio volumio[12568]: from aiohttp import web Oct 29 19:47:21 volumio volumio[12568]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:23 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:23 volumio volumio[960]: info: CoreStateMachine::setRandom true Oct 29 19:47:23 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:23 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:23 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:23 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9739. Oct 29 19:47:23 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:23 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:23 volumio volumio[12607]: Traceback (most recent call last): Oct 29 19:47:23 volumio volumio[12607]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:23 volumio volumio[12607]: from aiohttp import web Oct 29 19:47:23 volumio volumio[12607]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::volumioRandom Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::writePlayerControls Oct 29 19:47:23 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:23 volumio volumio[960]: info: CoreStateMachine::setRandom false Oct 29 19:47:23 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:23 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:23 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:24 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:24 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:24 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9740. Oct 29 19:47:25 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:25 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:25 volumio volumio[12609]: Traceback (most recent call last): Oct 29 19:47:25 volumio volumio[12609]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:25 volumio volumio[12609]: from aiohttp import web Oct 29 19:47:25 volumio volumio[12609]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:47:27 volumio volumio[960]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 29 19:47:27 volumio volumio[960]: info: Received Get System Version Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 19:47:27 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:27 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:27 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:27 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:27 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:27 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9741. Oct 29 19:47:27 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:27 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:27 volumio volumio[12610]: Traceback (most recent call last): Oct 29 19:47:27 volumio volumio[12610]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:27 volumio volumio[12610]: from aiohttp import web Oct 29 19:47:27 volumio volumio[12610]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9742. Oct 29 19:47:29 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:29 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:30 volumio volumio[12611]: Traceback (most recent call last): Oct 29 19:47:30 volumio volumio[12611]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:30 volumio volumio[12611]: from aiohttp import web Oct 29 19:47:30 volumio volumio[12611]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:31 volumio sudo[12613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 19:47:31 volumio sudo[12613]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:31 volumio sudo[12613]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:31 volumio sudo[12616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 19:47:31 volumio sudo[12616]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:31 volumio sudo[12616]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:31 volumio volumio[960]: verbose: New Socket.io Connection to 192.168.50.60 from 192.168.50.107 UA: Mozilla/5.0 (Linux; Android 11; Mi 9T Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::volumioGetVisibleSources Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:32 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:47:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9743. Oct 29 19:47:32 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:32 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:32 volumio volumio[12618]: Traceback (most recent call last): Oct 29 19:47:32 volumio volumio[12618]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:32 volumio volumio[12618]: from aiohttp import web Oct 29 19:47:32 volumio volumio[12618]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:32 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:32 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:32 volumio sudo[12620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 19:47:32 volumio sudo[12620]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:32 volumio sudo[12620]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:32 volumio sudo[12623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 19:47:32 volumio sudo[12623]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:47:32 volumio sudo[12623]: pam_unix(sudo:session): session closed for user root Oct 29 19:47:32 volumio volumio[960]: verbose: New Socket.io Connection to 192.168.50.60 from 192.168.50.107 UA: Mozilla/5.0 (Linux; Android 11; Mi 9T Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:32 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 29 19:47:32 volumio volumio[960]: info: Listing playlists Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 19:47:32 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:47:34 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:34 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:34 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:34 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 19:47:34 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:34 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:34 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:34 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:34 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:34 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:34 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:34 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:34 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9744. Oct 29 19:47:34 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:34 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:34 volumio volumio[12625]: Traceback (most recent call last): Oct 29 19:47:34 volumio volumio[12625]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:34 volumio volumio[12625]: from aiohttp import web Oct 29 19:47:34 volumio volumio[12625]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:34 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:34 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:36 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 19:47:36 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:36 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:36 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:36 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:36 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:36 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:36 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:36 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:36 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9745. Oct 29 19:47:36 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:36 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:36 volumio volumio[12626]: Traceback (most recent call last): Oct 29 19:47:36 volumio volumio[12626]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:36 volumio volumio[12626]: from aiohttp import web Oct 29 19:47:36 volumio volumio[12626]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:36 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:36 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:38 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:38 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9746. Oct 29 19:47:38 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:38 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:39 volumio volumio[12627]: Traceback (most recent call last): Oct 29 19:47:39 volumio volumio[12627]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:39 volumio volumio[12627]: from aiohttp import web Oct 29 19:47:39 volumio volumio[12627]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:41 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:41 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9747. Oct 29 19:47:41 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:41 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:41 volumio volumio[12628]: Traceback (most recent call last): Oct 29 19:47:41 volumio volumio[12628]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:41 volumio volumio[12628]: from aiohttp import web Oct 29 19:47:41 volumio volumio[12628]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:41 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:41 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioNext Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::next Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::stop Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::stPlaybackTimer Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::updateTrackBlock Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrackBlock Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::serviceStop Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 8 Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::serviceStop Oct 29 19:47:41 volumio volumio[960]: info: [1730224061404] ControllerUPNPBrowser::stop Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand stop took 16 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::play index undefined Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::startPlaybackTimer Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: info: [1730224061423] ControllerUPNPBrowser::clearAddPlayTrack Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::updateTrackBlock Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrackBlock Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand status took 8 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand stop took 5 milliseconds Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:41 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand clear took 3 milliseconds Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0Ng" Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Running From The Shadow","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0NQ","trackType":""} Oct 29 19:47:41 volumio volumio[960]: verbose: CURRENT POSITION 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState stateService stop Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus stop Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: No code Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 35ms Oct 29 19:47:41 volumio volumio[960]: error: updateQueue error: null Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 24ms Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0Ng" Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:41 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand add "http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0Ng" took 2 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand play Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 3ms Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand play took 2 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand status took 21 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:41 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:41 volumio volumio[960]: info: Oct 29 19:47:41 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand status took 7 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Speed","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0Ng","trackType":""} Oct 29 19:47:41 volumio volumio[960]: verbose: CURRENT POSITION 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus stop Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 41ms Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 14ms Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand status took 13 milliseconds Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1011 Kbps","isStreaming":false,"title":"Speed","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0Ng","trackType":""} Oct 29 19:47:41 volumio volumio[960]: verbose: CURRENT POSITION 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Oct 29 19:47:41 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 56ms Oct 29 19:47:41 volumio volumio[960]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 29 19:47:41 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:41 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:41 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1089 Kbps","isStreaming":false,"title":"Speed","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTA0Ng","trackType":""} Oct 29 19:47:41 volumio volumio[960]: verbose: CURRENT POSITION 9 Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Oct 29 19:47:41 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:41 volumio volumio[960]: info: ------------------------------ 96ms Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 19:47:41 volumio volumio[960]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:41 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:41 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:41 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:42 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:42 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:42 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:42 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:42 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:42 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:42 volumio kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=1) Oct 29 19:47:42 volumio volumio[960]: info: camilladsp spawned new process with pid 12634, instance 1, run: true Oct 29 19:47:43 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:43 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9748. Oct 29 19:47:43 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:43 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:43 volumio volumio[12641]: Traceback (most recent call last): Oct 29 19:47:43 volumio volumio[12641]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:43 volumio volumio[12641]: from aiohttp import web Oct 29 19:47:43 volumio volumio[12641]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:43 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:43 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:45 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:45 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9749. Oct 29 19:47:45 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:45 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:45 volumio volumio[12643]: Traceback (most recent call last): Oct 29 19:47:45 volumio volumio[12643]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:45 volumio volumio[12643]: from aiohttp import web Oct 29 19:47:45 volumio volumio[12643]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:45 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:45 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioNext Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::next Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::next Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand next Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:46 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand next took 10 milliseconds Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:46 volumio volumio[960]: error: updateQueue error: null Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 3ms Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand status took 2 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 9 Oct 29 19:47:46 volumio volumio[960]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 29 19:47:46 volumio volumio[960]: verbose: CURRENT POSITION 9 Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState stateService stop Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::play index undefined Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::startPlaybackTimer Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: info: [1730224066086] ControllerUPNPBrowser::clearAddPlayTrack Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 28ms Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand stop took 16 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:46 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand clear took 11 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw" Oct 29 19:47:46 volumio volumio[960]: error: updateQueue error: null Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 3ms Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw" Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:46 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand add "http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw" took 2 milliseconds Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand play Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 3ms Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand play took 2 milliseconds Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand status took 20 milliseconds Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand status took 4 milliseconds Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw","artist":null,"album":null,"uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw","trackType":""} Oct 29 19:47:46 volumio volumio[960]: verbose: CURRENT POSITION 10 Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus stop Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 32ms Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces system playlist update Oct 29 19:47:46 volumio volumio[960]: info: Ignoring MPD Status Update Oct 29 19:47:46 volumio volumio[960]: info: Oct 29 19:47:46 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Take Me High","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw","trackType":""} Oct 29 19:47:46 volumio volumio[960]: verbose: CURRENT POSITION 10 Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Oct 29 19:47:46 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 28ms Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 21ms Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand status took 19 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 19:47:46 volumio volumio[960]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:46 volumio volumio[960]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 29 19:47:46 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:47:46 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:47:46 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"887 Kbps","isStreaming":false,"title":"Take Me High","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw","trackType":""} Oct 29 19:47:46 volumio volumio[960]: verbose: CURRENT POSITION 10 Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Oct 29 19:47:46 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:47:46 volumio volumio[960]: info: ------------------------------ 55ms Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:47:46 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:47:46 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:47:46 volumio kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=1) Oct 29 19:47:46 volumio volumio[960]: info: camilladsp spawned new process with pid 12649, instance 1, run: true Oct 29 19:47:47 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:47 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9750. Oct 29 19:47:47 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:47 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:48 volumio volumio[12657]: Traceback (most recent call last): Oct 29 19:47:48 volumio volumio[12657]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:48 volumio volumio[12657]: from aiohttp import web Oct 29 19:47:48 volumio volumio[12657]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:48 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:48 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:48 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:48 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:50 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:50 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9751. Oct 29 19:47:50 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:50 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:50 volumio volumio[12658]: Traceback (most recent call last): Oct 29 19:47:50 volumio volumio[12658]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:50 volumio volumio[12658]: from aiohttp import web Oct 29 19:47:50 volumio volumio[12658]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:50 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:50 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:47:50 volumio volumio[960]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 29 19:47:50 volumio volumio[960]: info: Received Get System Version Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 19:47:50 volumio volumio[960]: info: Received Get System Info Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:47:50 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:47:50 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:47:52 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:52 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9752. Oct 29 19:47:52 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:52 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:52 volumio volumio[12659]: Traceback (most recent call last): Oct 29 19:47:52 volumio volumio[12659]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:52 volumio volumio[12659]: from aiohttp import web Oct 29 19:47:52 volumio volumio[12659]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:52 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:52 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:54 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:54 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9753. Oct 29 19:47:54 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:54 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:54 volumio volumio[12660]: Traceback (most recent call last): Oct 29 19:47:54 volumio volumio[12660]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:54 volumio volumio[12660]: from aiohttp import web Oct 29 19:47:54 volumio volumio[12660]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:54 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:54 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:56 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:56 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9754. Oct 29 19:47:56 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:56 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:57 volumio volumio[12661]: Traceback (most recent call last): Oct 29 19:47:57 volumio volumio[12661]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:57 volumio volumio[12661]: from aiohttp import web Oct 29 19:47:57 volumio volumio[12661]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:57 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:57 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:47:59 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:47:59 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9755. Oct 29 19:47:59 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:47:59 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:47:59 volumio volumio[12662]: Traceback (most recent call last): Oct 29 19:47:59 volumio volumio[12662]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:47:59 volumio volumio[12662]: from aiohttp import web Oct 29 19:47:59 volumio volumio[12662]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:47:59 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:47:59 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9756. Oct 29 19:48:01 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:01 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:01 volumio volumio[12663]: Traceback (most recent call last): Oct 29 19:48:01 volumio volumio[12663]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:01 volumio volumio[12663]: from aiohttp import web Oct 29 19:48:01 volumio volumio[12663]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:01 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:01 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9757. Oct 29 19:48:03 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:03 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:03 volumio volumio[12664]: Traceback (most recent call last): Oct 29 19:48:03 volumio volumio[12664]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:03 volumio volumio[12664]: from aiohttp import web Oct 29 19:48:03 volumio volumio[12664]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:03 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:03 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:05 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:05 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9758. Oct 29 19:48:05 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:05 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:06 volumio volumio[12666]: Traceback (most recent call last): Oct 29 19:48:06 volumio volumio[12666]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:06 volumio volumio[12666]: from aiohttp import web Oct 29 19:48:06 volumio volumio[12666]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:06 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:06 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:07 volumio sudo[12668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 19:48:07 volumio sudo[12668]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:48:07 volumio sudo[12668]: pam_unix(sudo:session): session closed for user root Oct 29 19:48:07 volumio sudo[12671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 19:48:07 volumio sudo[12671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:48:07 volumio sudo[12671]: pam_unix(sudo:session): session closed for user root Oct 29 19:48:07 volumio volumio[960]: verbose: New Socket.io Connection to 192.168.50.60 from 192.168.50.107 UA: Mozilla/5.0 (Linux; Android 11; Mi 9T Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 29 19:48:07 volumio sudo[12674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 19:48:07 volumio sudo[12674]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:48:07 volumio sudo[12674]: pam_unix(sudo:session): session closed for user root Oct 29 19:48:07 volumio sudo[12677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 19:48:07 volumio sudo[12677]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 19:48:07 volumio sudo[12677]: pam_unix(sudo:session): session closed for user root Oct 29 19:48:07 volumio volumio[960]: verbose: New Socket.io Connection to 192.168.50.60 from 192.168.50.107 UA: Mozilla/5.0 (Linux; Android 11; Mi 9T Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 29 19:48:07 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:48:07 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 29 19:48:07 volumio volumio[960]: info: Listing playlists Oct 29 19:48:07 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 19:48:07 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 19:48:07 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 19:48:07 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:48:08 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:08 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9759. Oct 29 19:48:08 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:08 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:08 volumio volumio[12679]: Traceback (most recent call last): Oct 29 19:48:08 volumio volumio[12679]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:08 volumio volumio[12679]: from aiohttp import web Oct 29 19:48:08 volumio volumio[12679]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:08 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:08 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:09 volumio volumio[960]: info: CoreCommandRouter::volumioGetQueue Oct 29 19:48:09 volumio volumio[960]: info: CoreStateMachine::getQueue Oct 29 19:48:09 volumio volumio[960]: info: CorePlayQueue::getQueue Oct 29 19:48:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 19:48:09 volumio volumio[960]: info: Received Get System Info Oct 29 19:48:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:48:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:48:09 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:48:09 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:48:09 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:48:10 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:10 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9760. Oct 29 19:48:10 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:10 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:10 volumio volumio[12680]: Traceback (most recent call last): Oct 29 19:48:10 volumio volumio[12680]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:10 volumio volumio[12680]: from aiohttp import web Oct 29 19:48:10 volumio volumio[12680]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:10 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:10 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 19:48:10 volumio volumio[960]: info: Received Get System Info Oct 29 19:48:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:48:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:48:10 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:48:10 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:48:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:48:12 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:12 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9761. Oct 29 19:48:12 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:12 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:12 volumio volumio[12681]: Traceback (most recent call last): Oct 29 19:48:12 volumio volumio[12681]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:12 volumio volumio[12681]: from aiohttp import web Oct 29 19:48:12 volumio volumio[12681]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9762. Oct 29 19:48:14 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:14 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:15 volumio volumio[12682]: Traceback (most recent call last): Oct 29 19:48:15 volumio volumio[12682]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:15 volumio volumio[12682]: from aiohttp import web Oct 29 19:48:15 volumio volumio[12682]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:15 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:15 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9763. Oct 29 19:48:17 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:17 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:17 volumio volumio[12683]: Traceback (most recent call last): Oct 29 19:48:17 volumio volumio[12683]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:17 volumio volumio[12683]: from aiohttp import web Oct 29 19:48:17 volumio volumio[12683]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:17 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:17 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:48:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:48:18 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:48:18 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:48:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:48:19 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:19 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9764. Oct 29 19:48:19 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:19 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:19 volumio volumio[960]: info: CoreCommandRouter::volumioGetVisibleSources Oct 29 19:48:19 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 19:48:19 volumio volumio[12684]: Traceback (most recent call last): Oct 29 19:48:19 volumio volumio[12684]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:19 volumio volumio[12684]: from aiohttp import web Oct 29 19:48:19 volumio volumio[12684]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:19 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:19 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:21 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:21 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9765. Oct 29 19:48:21 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:21 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:21 volumio volumio[12685]: Traceback (most recent call last): Oct 29 19:48:21 volumio volumio[12685]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:21 volumio volumio[12685]: from aiohttp import web Oct 29 19:48:21 volumio volumio[12685]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:21 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:21 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:23 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:23 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9766. Oct 29 19:48:23 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:23 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:24 volumio volumio[12724]: Traceback (most recent call last): Oct 29 19:48:24 volumio volumio[12724]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:24 volumio volumio[12724]: from aiohttp import web Oct 29 19:48:24 volumio volumio[12724]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:24 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:24 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:25 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 19:48:25 volumio volumio[960]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 29 19:48:25 volumio volumio[960]: info: Received Get System Version Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 19:48:25 volumio volumio[960]: info: Received Get System Info Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:48:25 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:48:25 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:48:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9767. Oct 29 19:48:26 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:26 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:26 volumio volumio[12726]: Traceback (most recent call last): Oct 29 19:48:26 volumio volumio[12726]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:26 volumio volumio[12726]: from aiohttp import web Oct 29 19:48:26 volumio volumio[12726]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:26 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:26 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:28 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:28 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:28 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9768. Oct 29 19:48:28 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:28 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:28 volumio volumio[12727]: Traceback (most recent call last): Oct 29 19:48:28 volumio volumio[12727]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:28 volumio volumio[12727]: from aiohttp import web Oct 29 19:48:28 volumio volumio[12727]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:28 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:28 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:28 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9769. Oct 29 19:48:30 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:30 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:30 volumio volumio[12728]: Traceback (most recent call last): Oct 29 19:48:30 volumio volumio[12728]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:30 volumio volumio[12728]: from aiohttp import web Oct 29 19:48:30 volumio volumio[12728]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:30 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:30 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:30 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:31 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:32 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:32 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9770. Oct 29 19:48:32 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:32 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:33 volumio volumio[12729]: Traceback (most recent call last): Oct 29 19:48:33 volumio volumio[12729]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:33 volumio volumio[12729]: from aiohttp import web Oct 29 19:48:33 volumio volumio[12729]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:33 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:33 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:33 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:33 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9771. Oct 29 19:48:35 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:35 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:35 volumio volumio[12730]: Traceback (most recent call last): Oct 29 19:48:35 volumio volumio[12730]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:35 volumio volumio[12730]: from aiohttp import web Oct 29 19:48:35 volumio volumio[12730]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:35 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:35 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:37 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:37 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9772. Oct 29 19:48:37 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:37 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:37 volumio volumio[12731]: Traceback (most recent call last): Oct 29 19:48:37 volumio volumio[12731]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:37 volumio volumio[12731]: from aiohttp import web Oct 29 19:48:37 volumio volumio[12731]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:37 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:37 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:37 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:37 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:39 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:39 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9773. Oct 29 19:48:39 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:39 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:39 volumio volumio[12732]: Traceback (most recent call last): Oct 29 19:48:39 volumio volumio[12732]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:39 volumio volumio[12732]: from aiohttp import web Oct 29 19:48:39 volumio volumio[12732]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:39 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:39 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:41 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:41 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9774. Oct 29 19:48:41 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:41 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:42 volumio volumio[12733]: Traceback (most recent call last): Oct 29 19:48:42 volumio volumio[12733]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:42 volumio volumio[12733]: from aiohttp import web Oct 29 19:48:42 volumio volumio[12733]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:42 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:42 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:42 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:42 volumio volumio[960]: info: Preloading song: upnp/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be-4744 Oct 29 19:48:42 volumio volumio[960]: info: Exploding uri upnp/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be-4744 in service upnp_browser Oct 29 19:48:44 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:44 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9775. Oct 29 19:48:44 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:44 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:44 volumio volumio[12734]: Traceback (most recent call last): Oct 29 19:48:44 volumio volumio[12734]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:44 volumio volumio[12734]: from aiohttp import web Oct 29 19:48:44 volumio volumio[12734]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:44 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:44 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:44 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:44 volumio volumio[960]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::ClearQueue Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::stop Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::stPlaybackTimer Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::updateTrackBlock Oct 29 19:48:44 volumio volumio[960]: info: CorePlayQueue::getTrackBlock Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:48:44 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:48:44 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:48:44 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::serviceStop Oct 29 19:48:44 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:48:44 volumio volumio[960]: info: CoreCommandRouter::serviceStop Oct 29 19:48:44 volumio volumio[960]: info: [1730224124979] ControllerUPNPBrowser::stop Oct 29 19:48:44 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 19:48:44 volumio volumio[960]: info: CorePlayQueue::clearPlayQueue Oct 29 19:48:44 volumio volumio[960]: info: CorePlayQueue::saveQueue Oct 29 19:48:44 volumio volumio[960]: info: CoreCommandRouter::volumioPushQueue Oct 29 19:48:44 volumio volumio[960]: info: CoreStateMachine::addQueueItems Oct 29 19:48:44 volumio volumio[960]: info: CorePlayQueue::addQueueItems Oct 29 19:48:44 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:44 volumio volumio[960]: info: Adding Item to queue: upnp/folder/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be_b1d57c10 Oct 29 19:48:44 volumio volumio[960]: info: Exploding uri upnp/folder/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be_b1d57c10 in service upnp_browser Oct 29 19:48:44 volumio volumio[960]: info: Adding Item to queue: upnp/folder/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be_3383291 Oct 29 19:48:44 volumio volumio[960]: info: Exploding uri upnp/folder/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be_3383291 in service upnp_browser Oct 29 19:48:44 volumio volumio[960]: info: Adding Item to queue: upnp/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be-4744 Oct 29 19:48:44 volumio volumio[960]: info: Using cached record of: upnp/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be-4744 Oct 29 19:48:45 volumio volumio[960]: info: Oct 29 19:48:45 volumio volumio[960]: ---------------------------- MPD announces state update: player Oct 29 19:48:45 volumio volumio[960]: info: sendMpdCommand stop took 28 milliseconds Oct 29 19:48:45 volumio volumio[960]: info: ControllerMpd::getState Oct 29 19:48:45 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Oct 29 19:48:45 volumio volumio[960]: info: sendMpdCommand status took 1 milliseconds Oct 29 19:48:45 volumio volumio[960]: verbose: ControllerMpd::parseState Oct 29 19:48:45 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 19:48:45 volumio volumio[960]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 19:48:45 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Oct 29 19:48:45 volumio volumio[960]: info: ControllerMpd::pushState Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::servicePushState Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:48:45 volumio volumio[960]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Take Me High","artist":"Dario Mollo's Crossbones","album":"Rock The Cradle (Japan)","uri":"http://192.168.50.214:10243/WMPNSSv4/3476502427/0_MTRfZmNiNmYwOTJfODYwM2EwNWMtNTAzNw","trackType":""} Oct 29 19:48:45 volumio volumio[960]: verbose: CURRENT POSITION 10 Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::syncState stateService stop Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus stop Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:48:45 volumio volumio[960]: info: No code Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::pushState Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::getTrack 10 Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Oct 29 19:48:45 volumio volumio[960]: info: ------------------------------ 23ms Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::volumioPushQueue Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::saveQueue Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::updateTrackBlock Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::getTrackBlock Oct 29 19:48:45 volumio volumio[960]: info: CoreCommandRouter::volumioPlay Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::play index 2 Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::stop Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::play index undefined Oct 29 19:48:45 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 19:48:45 volumio volumio[960]: info: CorePlayQueue::getTrack 2 Oct 29 19:48:45 volumio kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=1) Oct 29 19:48:45 volumio volumio[960]: info: camilladsp spawned new process with pid 12736, instance 1, run: true Oct 29 19:48:46 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:46 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9776. Oct 29 19:48:46 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:46 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:46 volumio volumio[12743]: Traceback (most recent call last): Oct 29 19:48:46 volumio volumio[12743]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:46 volumio volumio[12743]: from aiohttp import web Oct 29 19:48:46 volumio volumio[12743]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:46 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:46 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 19:48:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 19:48:48 volumio volumio[960]: info: Discovery: Getting this device information Oct 29 19:48:48 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Oct 29 19:48:48 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Oct 29 19:48:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 19:48:48 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:48 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9777. Oct 29 19:48:48 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:48 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:48 volumio volumio[12744]: Traceback (most recent call last): Oct 29 19:48:48 volumio volumio[12744]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:48 volumio volumio[12744]: from aiohttp import web Oct 29 19:48:48 volumio volumio[12744]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:48 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:48 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:50 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:50 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9778. Oct 29 19:48:50 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:50 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:51 volumio volumio[12745]: Traceback (most recent call last): Oct 29 19:48:51 volumio volumio[12745]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:51 volumio volumio[12745]: from aiohttp import web Oct 29 19:48:51 volumio volumio[12745]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:51 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:51 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:51 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:51 volumio volumio[960]: info: Preload queue cleared Oct 29 19:48:51 volumio volumio[960]: info: Preloading song: upnp/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be_3383291-4937 Oct 29 19:48:51 volumio volumio[960]: info: Exploding uri upnp/http://192.168.50.214:2869/upnphost/udhisapi.dll?control=uuid:831ef5a1-1928-4b31-9168-05c6928ada82+urn:upnp-org:serviceId:ContentDirectory@14_fcb6f092_5fb59a97_7cd776be_3383291-4937 in service upnp_browser Oct 29 19:48:53 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:53 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9779. Oct 29 19:48:53 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:53 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:53 volumio volumio[12746]: Traceback (most recent call last): Oct 29 19:48:53 volumio volumio[12746]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:53 volumio volumio[12746]: from aiohttp import web Oct 29 19:48:53 volumio volumio[12746]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:53 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:53 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:55 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Oct 29 19:48:55 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9780. Oct 29 19:48:55 volumio systemd[1]: Stopped FusionDsp Daemon. Oct 29 19:48:55 volumio systemd[1]: Started FusionDsp Daemon. Oct 29 19:48:55 volumio volumio[12747]: Traceback (most recent call last): Oct 29 19:48:55 volumio volumio[12747]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Oct 29 19:48:55 volumio volumio[12747]: from aiohttp import web Oct 29 19:48:55 volumio volumio[12747]: ModuleNotFoundError: No module named 'aiohttp' Oct 29 19:48:55 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Oct 29 19:48:55 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 29 19:48:56 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 19:48:56 volumio volumio[960]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 19:48:56 volumio volumio[960]: TypeError: Cannot read property 'length' of undefined Oct 29 19:48:56 volumio volumio[960]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 29 19:48:56 volumio volumio[960]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 29 19:48:56 volumio volumio[960]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 29 19:48:56 volumio volumio[960]: at Parser.emit (events.js:315:20) Oct 29 19:48:56 volumio volumio[960]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 29 19:48:56 volumio volumio[960]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 29 19:48:56 volumio volumio[960]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 29 19:48:56 volumio volumio[960]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 29 19:48:56 volumio volumio[960]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 29 19:48:56 volumio volumio[960]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 29 19:48:56 volumio volumio[960]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 29 19:48:56 volumio volumio[960]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 29 19:48:56 volumio volumio[960]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 29 19:48:56 volumio volumio[960]: at IncomingMessage.emit (events.js:327:22) Oct 29 19:48:56 volumio volumio[960]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 29 19:48:56 volumio volumio[960]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 29 19:48:56 volumio volumio[960]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 19:48:57 volumio sudo[12757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-29 19:47 Oct 29 19:48:57 volumio sudo[12757]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"