-- Logs begin at Wed 2024-04-03 15:47:10 UTC, end at Wed 2024-04-03 15:52:30 UTC. -- Apr 03 15:51:00 volumio volumio[572]: info: Creating Start Script Apr 03 15:51:00 volumio systemd[1]: Reloading. Apr 03 15:51:00 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 03 15:51:00 volumio sudo[2476]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:00 volumio volumio[572]: info: Install script completed Apr 03 15:51:00 volumio volumio[572]: info: Adding reference to registry Apr 03 15:51:00 volumio volumio[572]: info: Done installing plugin. Apr 03 15:51:00 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 15:51:00 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 03 15:51:00 volumio volumio[572]: Plugin install end detected on script Apr 03 15:51:00 volumio volumio[572]: info: Folder /tmp/plugins removed Apr 03 15:51:00 volumio volumio[572]: info: Folder /tmp/downloaded_plugin.zip removed Apr 03 15:51:00 volumio volumio[572]: info: Folder /data/temp removed Apr 03 15:51:00 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:00 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:01 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:01 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 8. Apr 03 15:51:01 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:01 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:01 volumio volumio[2522]: Traceback (most recent call last): Apr 03 15:51:01 volumio volumio[2522]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:01 volumio volumio[2522]: from aiohttp import web Apr 03 15:51:01 volumio volumio[2522]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:01 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:01 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:03 volumio volumio[572]: info: Enabling plugin spop Apr 03 15:51:03 volumio volumio[572]: info: Loading plugin "spop"... Apr 03 15:51:03 volumio volumio[572]: info: PLUGIN START: spop Apr 03 15:51:03 volumio volumio[572]: info: Creating Spotify config file Apr 03 15:51:03 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 15:51:03 volumio volumio[572]: info: Done. Apr 03 15:51:03 volumio volumio[572]: info: Spotify config file written Apr 03 15:51:03 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:03 volumio sudo[2524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 15:51:03 volumio sudo[2524]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:51:03 volumio systemd[1]: Started go-librespot Daemon. Apr 03 15:51:03 volumio go-librespot[2526]: Librespot-go daemon starting... Apr 03 15:51:03 volumio sudo[2524]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:03 volumio go-librespot[2526]: time="2024-04-03T15:51:03Z" level=info msg="generated new device id: 10ece15a594c6b753b0e2ae98bdd42bb62d1f92a" Apr 03 15:51:03 volumio go-librespot[2526]: time="2024-04-03T15:51:03Z" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 15:51:03 volumio go-librespot[2526]: time="2024-04-03T15:51:03Z" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 15:51:03 volumio go-librespot[2526]: time="2024-04-03T15:51:03Z" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 15:51:03 volumio go-librespot[2526]: time="2024-04-03T15:51:03Z" level=debug msg="zeroconf server listening on port 37603" Apr 03 15:51:03 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:03 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 9. Apr 03 15:51:03 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:03 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:04 volumio volumio[2532]: Traceback (most recent call last): Apr 03 15:51:04 volumio volumio[2532]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:04 volumio volumio[2532]: from aiohttp import web Apr 03 15:51:04 volumio volumio[2532]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:04 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:04 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:06 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:06 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 10. Apr 03 15:51:06 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:06 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:06 volumio volumio[2534]: Traceback (most recent call last): Apr 03 15:51:06 volumio volumio[2534]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:06 volumio volumio[2534]: from aiohttp import web Apr 03 15:51:06 volumio volumio[2534]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:06 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:06 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:06 volumio volumio[572]: info: go-librespot daemon successfully initialized Apr 03 15:51:08 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:08 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 11. Apr 03 15:51:08 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:08 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:08 volumio volumio[2537]: Traceback (most recent call last): Apr 03 15:51:08 volumio volumio[2537]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:08 volumio volumio[2537]: from aiohttp import web Apr 03 15:51:08 volumio volumio[2537]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:08 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:08 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:09 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:51:09 volumio go-librespot[2526]: time="2024-04-03T15:51:09Z" level=debug msg="new websocket client" Apr 03 15:51:09 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:51:10 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:10 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 12. Apr 03 15:51:10 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:10 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:10 volumio volumio[2538]: Traceback (most recent call last): Apr 03 15:51:10 volumio volumio[2538]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:10 volumio volumio[2538]: from aiohttp import web Apr 03 15:51:10 volumio volumio[2538]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:10 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:10 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:12 volumio volumio[572]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64 Apr 03 15:51:12 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:51:12 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Apr 03 15:51:12 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:12 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:12 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:51:12 volumio volumio[572]: SPOTIFY: SPOTIFY VOLUME undefined Apr 03 15:51:12 volumio volumio[572]: SPOTIFY: VOLUMIO VOLUME 41 Apr 03 15:51:12 volumio volumio[572]: info: Aligning Spotify Volume to Volumio Volume Apr 03 15:51:12 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:12 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:12 volumio volumio[572]: info: Setting Spotify Volume from Volumio: 41 Apr 03 15:51:12 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:12 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 13. Apr 03 15:51:12 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:12 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:13 volumio volumio[2588]: Traceback (most recent call last): Apr 03 15:51:13 volumio volumio[2588]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:13 volumio volumio[2588]: from aiohttp import web Apr 03 15:51:13 volumio volumio[2588]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:13 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:13 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:14 volumio volumio[572]: SPOTIFY: SETTING SPOTIFY VOLUME 41 Apr 03 15:51:14 volumio volumio[572]: info: Sending Spotify command with payload to local API: /player/volume Apr 03 15:51:14 volumio volumio[572]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64 Apr 03 15:51:14 volumio volumio[572]: info: Folder /tmp/plugins removed Apr 03 15:51:15 volumio volumio[572]: info: Check plugin dependencies Apr 03 15:51:15 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 15:51:15 volumio volumio[572]: info: Checking if plugin already exists Apr 03 15:51:15 volumio volumio[572]: info: Rename folder Apr 03 15:51:15 volumio volumio[572]: info: Folder /tmp/downloaded_plugin.zip removed Apr 03 15:51:15 volumio volumio[572]: info: Move to category Apr 03 15:51:15 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:15 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 14. Apr 03 15:51:15 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:15 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:15 volumio volumio[2599]: Traceback (most recent call last): Apr 03 15:51:15 volumio volumio[2599]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:15 volumio volumio[2599]: from aiohttp import web Apr 03 15:51:15 volumio volumio[2599]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:15 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:15 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 15. Apr 03 15:51:17 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:17 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:17 volumio volumio[2600]: Traceback (most recent call last): Apr 03 15:51:17 volumio volumio[2600]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:17 volumio volumio[2600]: from aiohttp import web Apr 03 15:51:17 volumio volumio[2600]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:17 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:17 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:18 volumio volumio[572]: info: Checking if install.sh is present Apr 03 15:51:18 volumio volumio[572]: info: Executing install.sh Apr 03 15:51:18 volumio sudo[2603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/now_playing/install.sh Apr 03 15:51:18 volumio sudo[2603]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:51:18 volumio volumio[572]: info: Installing geo-tz node dependency Apr 03 15:51:19 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:19 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 16. Apr 03 15:51:19 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:19 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:19 volumio volumio[2617]: Traceback (most recent call last): Apr 03 15:51:19 volumio volumio[2617]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:19 volumio volumio[2617]: from aiohttp import web Apr 03 15:51:19 volumio volumio[2617]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:19 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:19 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:21 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:21 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 17. Apr 03 15:51:21 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:21 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:22 volumio volumio[2618]: Traceback (most recent call last): Apr 03 15:51:22 volumio volumio[2618]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:22 volumio volumio[2618]: from aiohttp import web Apr 03 15:51:22 volumio volumio[2618]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:22 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:22 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:24 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:24 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 18. Apr 03 15:51:24 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:24 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:24 volumio volumio[2619]: Traceback (most recent call last): Apr 03 15:51:24 volumio volumio[2619]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:24 volumio volumio[2619]: from aiohttp import web Apr 03 15:51:24 volumio volumio[2619]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:24 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:24 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:26 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:26 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 19. Apr 03 15:51:26 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:26 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:26 volumio volumio[2621]: Traceback (most recent call last): Apr 03 15:51:26 volumio volumio[2621]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:26 volumio volumio[2621]: from aiohttp import web Apr 03 15:51:26 volumio volumio[2621]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:26 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:26 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:28 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:28 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 20. Apr 03 15:51:28 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:28 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:28 volumio volumio[2622]: Traceback (most recent call last): Apr 03 15:51:28 volumio volumio[2622]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:28 volumio volumio[2622]: from aiohttp import web Apr 03 15:51:28 volumio volumio[2622]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:28 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:28 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:30 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:30 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 21. Apr 03 15:51:30 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:30 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:31 volumio volumio[2623]: Traceback (most recent call last): Apr 03 15:51:31 volumio volumio[2623]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:31 volumio volumio[2623]: from aiohttp import web Apr 03 15:51:31 volumio volumio[2623]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:31 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:31 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:33 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:33 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 22. Apr 03 15:51:33 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:33 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:33 volumio volumio[2624]: Traceback (most recent call last): Apr 03 15:51:33 volumio volumio[2624]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:33 volumio volumio[2624]: from aiohttp import web Apr 03 15:51:33 volumio volumio[2624]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:33 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:33 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:34 volumio volumio[572]: info: Creating user directories (if not exist) Apr 03 15:51:34 volumio sudo[2603]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:34 volumio volumio[572]: info: Install script completed Apr 03 15:51:34 volumio volumio[572]: info: Adding reference to registry Apr 03 15:51:34 volumio volumio[572]: info: Done installing plugin. Apr 03 15:51:34 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 15:51:34 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 03 15:51:34 volumio volumio[572]: info: Now Playing plugin installed Apr 03 15:51:34 volumio volumio[572]: Plugin install end detected on script Apr 03 15:51:34 volumio volumio[572]: info: Folder /tmp/plugins removed Apr 03 15:51:34 volumio volumio[572]: info: Folder /tmp/downloaded_plugin.zip removed Apr 03 15:51:34 volumio volumio[572]: info: Folder /data/temp removed Apr 03 15:51:34 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:34 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:35 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:35 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 23. Apr 03 15:51:35 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:35 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:35 volumio volumio[2632]: Traceback (most recent call last): Apr 03 15:51:35 volumio volumio[2632]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:35 volumio volumio[2632]: from aiohttp import web Apr 03 15:51:35 volumio volumio[2632]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:35 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:35 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:37 volumio volumio[572]: info: Enabling plugin now_playing Apr 03 15:51:37 volumio volumio[572]: info: Loading plugin "now_playing"... Apr 03 15:51:37 volumio volumio[572]: error: !!!! WARNING !!!! Apr 03 15:51:37 volumio volumio[572]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Apr 03 15:51:37 volumio volumio[572]: Require stack: Apr 03 15:51:37 volumio volumio[572]: - /data/plugins/user_interface/now_playing/dist/index.js Apr 03 15:51:37 volumio volumio[572]: - /volumio/app/pluginmanager.js Apr 03 15:51:37 volumio volumio[572]: - /volumio/app/index.js Apr 03 15:51:37 volumio volumio[572]: - /volumio/index.js Apr 03 15:51:37 volumio volumio[572]: error: Stack trace: Error: Cannot find module 'geo-tz' Apr 03 15:51:37 volumio volumio[572]: Require stack: Apr 03 15:51:37 volumio volumio[572]: - /data/plugins/user_interface/now_playing/dist/index.js Apr 03 15:51:37 volumio volumio[572]: - /volumio/app/pluginmanager.js Apr 03 15:51:37 volumio volumio[572]: - /volumio/app/index.js Apr 03 15:51:37 volumio volumio[572]: - /volumio/index.js Apr 03 15:51:37 volumio volumio[572]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15) Apr 03 15:51:37 volumio volumio[572]: at Function.Module._load (internal/modules/cjs/loader.js:774:27) Apr 03 15:51:37 volumio volumio[572]: at Module.require (internal/modules/cjs/loader.js:1003:19) Apr 03 15:51:37 volumio volumio[572]: at require (internal/modules/cjs/helpers.js:107:18) Apr 03 15:51:37 volumio volumio[572]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Apr 03 15:51:37 volumio volumio[572]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Apr 03 15:51:37 volumio volumio[572]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Apr 03 15:51:37 volumio volumio[572]: at Module.load (internal/modules/cjs/loader.js:979:32) Apr 03 15:51:37 volumio volumio[572]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Apr 03 15:51:37 volumio volumio[572]: at Module.require (internal/modules/cjs/loader.js:1003:19) Apr 03 15:51:37 volumio volumio[572]: at require (internal/modules/cjs/helpers.js:107:18) Apr 03 15:51:37 volumio volumio[572]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Apr 03 15:51:37 volumio volumio[572]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 03 15:51:37 volumio volumio[572]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 03 15:51:37 volumio volumio[572]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 03 15:51:37 volumio volumio[572]: error: !!!! WARNING !!!! Apr 03 15:51:37 volumio volumio[572]: info: Done. Apr 03 15:51:37 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:37 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:37 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 24. Apr 03 15:51:37 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:37 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:37 volumio volumio[2634]: Traceback (most recent call last): Apr 03 15:51:37 volumio volumio[2634]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:37 volumio volumio[2634]: from aiohttp import web Apr 03 15:51:37 volumio volumio[2634]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:37 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:37 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:39 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:39 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 25. Apr 03 15:51:39 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:39 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:40 volumio volumio[2636]: Traceback (most recent call last): Apr 03 15:51:40 volumio volumio[2636]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:40 volumio volumio[2636]: from aiohttp import web Apr 03 15:51:40 volumio volumio[2636]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:40 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:40 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:42 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:42 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 26. Apr 03 15:51:42 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:42 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:42 volumio volumio[2637]: Traceback (most recent call last): Apr 03 15:51:42 volumio volumio[2637]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:42 volumio volumio[2637]: from aiohttp import web Apr 03 15:51:42 volumio volumio[2637]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:42 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:42 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:42 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:44 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:44 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 27. Apr 03 15:51:44 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:44 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:44 volumio volumio[2638]: Traceback (most recent call last): Apr 03 15:51:44 volumio volumio[2638]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:44 volumio volumio[2638]: from aiohttp import web Apr 03 15:51:44 volumio volumio[2638]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:44 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:44 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:46 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:46 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 28. Apr 03 15:51:46 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:46 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:46 volumio volumio[2640]: Traceback (most recent call last): Apr 03 15:51:46 volumio volumio[2640]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:46 volumio volumio[2640]: from aiohttp import web Apr 03 15:51:46 volumio volumio[2640]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:46 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:46 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:48 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:48 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 29. Apr 03 15:51:48 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:49 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:49 volumio volumio[2641]: Traceback (most recent call last): Apr 03 15:51:49 volumio volumio[2641]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:49 volumio volumio[2641]: from aiohttp import web Apr 03 15:51:49 volumio volumio[2641]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:49 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:49 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:50 volumio ntpd[1121]: Soliciting pool server 2606:4700:f1::123 Apr 03 15:51:51 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:51 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 30. Apr 03 15:51:51 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:51 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:51 volumio volumio[2642]: Traceback (most recent call last): Apr 03 15:51:51 volumio volumio[2642]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:51 volumio volumio[2642]: from aiohttp import web Apr 03 15:51:51 volumio volumio[2642]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:51 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:51 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:51 volumio volumio[572]: info: Received OAUTH Data Apr 03 15:51:51 volumio volumio[572]: info: Executing Spotify Oauth Login Apr 03 15:51:51 volumio volumio[572]: info: Saving Spotify Refresh Token Apr 03 15:51:51 volumio sudo[2644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 15:51:51 volumio sudo[2644]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:51:51 volumio sudo[2646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 15:51:51 volumio sudo[2646]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:51:51 volumio sudo[2644]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:51 volumio sudo[2646]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:51 volumio volumio[572]: verbose: New Socket.io Connection to 192.168.88.93 from 192.168.88.45 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 7 Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:52 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 15:51:52 volumio volumio[572]: info: Received Get System Info Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 15:51:52 volumio volumio[572]: info: Discovery: Getting this device information Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:52 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:52 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:52 volumio volumio[572]: info: Listing playlists Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:51:52 volumio volumio[572]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 03 15:51:52 volumio volumio[572]: SPOTIFY: BQDLV13TZJZrrfuChQzbDfC7Bc9F-1cEqB9S8RB-ZyYWYq6aZLGt9svb-_L2cE5XpScGQSJRuWWsEsiQ5wyuBEE0NrlW_S2t2LpZiOUO_QkY7sXvuox2z0wGm0ea3peQCXcO6ik897pYmJxfZ44GkvRnfimG8MbpgCyEdIbgeVXeyqf9fCSgrU9mHuEidJAY0M8oxalFo35eMxJiqyrgiIbDYtfzLE3Lc2ngGz7TS2BlRqijymY Apr 03 15:51:52 volumio volumio[572]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 03 15:51:52 volumio volumio[572]: info: New Spotify access token = BQDLV13TZJZrrfuChQzbDfC7Bc9F-1cEqB9S8RB-ZyYWYq6aZLGt9svb-_L2cE5XpScGQSJRuWWsEsiQ5wyuBEE0NrlW_S2t2LpZiOUO_QkY7sXvuox2z0wGm0ea3peQCXcO6ik897pYmJxfZ44GkvRnfimG8MbpgCyEdIbgeVXeyqf9fCSgrU9mHuEidJAY0M8oxalFo35eMxJiqyrgiIbDYtfzLE3Lc2ngGz7TS2BlRqijymY Apr 03 15:51:52 volumio volumio[572]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 03 15:51:52 volumio volumio[572]: SPOTIFY: User informations: {"display_name":"tecnolabsf","external_urls":{"spotify":"https://open.spotify.com/user/tecnolabsf"},"href":"https://api.spotify.com/v1/users/tecnolabsf","id":"tecnolabsf","images":[],"type":"user","uri":"spotify:user:tecnolabsf","followers":{"href":null,"total":1},"country":"AR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"ventas@tecnolab.ar"} Apr 03 15:51:52 volumio volumio[572]: info: Creating Spotify config file Apr 03 15:51:52 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 15:51:52 volumio volumio[572]: info: Spotify config file written Apr 03 15:51:52 volumio sudo[2652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 15:51:52 volumio sudo[2652]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:51:52 volumio systemd[1]: Stopping go-librespot Daemon... Apr 03 15:51:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 03 15:51:52 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Apr 03 15:51:52 volumio systemd[1]: Stopped go-librespot Daemon. Apr 03 15:51:52 volumio volumio[572]: info: Connection to go-librespot Websocket closed Apr 03 15:51:52 volumio systemd[1]: Started go-librespot Daemon. Apr 03 15:51:52 volumio go-librespot[2654]: Librespot-go daemon starting... Apr 03 15:51:52 volumio sudo[2652]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:52 volumio go-librespot[2654]: time="2024-04-03T15:51:52Z" level=info msg="generated new device id: e8fa8a862004298e4213dd6eb7a3f1cdce33ed12" Apr 03 15:51:52 volumio go-librespot[2654]: time="2024-04-03T15:51:52Z" level=debug msg="stored credentials not found" Apr 03 15:51:53 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:53 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 31. Apr 03 15:51:53 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:53 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:53 volumio volumio[2659]: Traceback (most recent call last): Apr 03 15:51:53 volumio volumio[2659]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:53 volumio volumio[2659]: from aiohttp import web Apr 03 15:51:53 volumio volumio[2659]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:53 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:53 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:53 volumio go-librespot[2654]: time="2024-04-03T15:51:53Z" level=debug msg="obtained new client token: AAA03/uh1a2C4ku/GzwTkxozI2CNFz+v0KqRfYIO0Dw8p+tu+4jaapye0sBeRAY8jx8siofMUCXyY0yOL8G9Ei9eavMVaqwmksUeIrPsdX8vrHusjTOO3dzYXqhnRMnNX5JFjhgI+fV+WodaoFV3fvd7sIRPLNT0wkK1ch0NTvP+asKY0W4xBdBwYYoWulHLh2UAh9xuSEo/rGYwQeDk9gluYWgRKN7q9K9w0EPQpf72pW0pC7Neq+A6uX8HRKk=" Apr 03 15:51:53 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 15:51:53 volumio volumio[572]: info: Received Get System Info Apr 03 15:51:53 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 15:51:53 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 15:51:53 volumio volumio[572]: info: Discovery: Getting this device information Apr 03 15:51:53 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:53 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:53 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 15:51:53 volumio go-librespot[2654]: time="2024-04-03T15:51:53Z" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 15:51:54 volumio go-librespot[2654]: time="2024-04-03T15:51:54Z" level=debug msg="completed keyexchange" Apr 03 15:51:54 volumio volumio[572]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 03 15:51:54 volumio volumio[572]: SPOTIFY: BQCQe1yyyRoQfIBd4CmAY-bfSIZ8tl6ApJCSNxnfa2m5vm-Y1T2TJH3lgXBLITwhXfPbs9HvWD-YnzMps29j6syAtL480bRsxZZun53oogdpKdoLbZ79MwPrSEsm6tpNvk07Z8phCGfwIbiufGwJNSbM_bdOZ5CFcEC1y43HqJ2DhfnQFw0gvLM58FE-k3nyCsUqmqZxtnkNspZTR2m9AgQ50lkpBGWakXEhupVl06dU95Fy9J8 Apr 03 15:51:54 volumio volumio[572]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 03 15:51:54 volumio volumio[572]: info: New Spotify access token = BQCQe1yyyRoQfIBd4CmAY-bfSIZ8tl6ApJCSNxnfa2m5vm-Y1T2TJH3lgXBLITwhXfPbs9HvWD-YnzMps29j6syAtL480bRsxZZun53oogdpKdoLbZ79MwPrSEsm6tpNvk07Z8phCGfwIbiufGwJNSbM_bdOZ5CFcEC1y43HqJ2DhfnQFw0gvLM58FE-k3nyCsUqmqZxtnkNspZTR2m9AgQ50lkpBGWakXEhupVl06dU95Fy9J8 Apr 03 15:51:54 volumio volumio[572]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 03 15:51:54 volumio volumio[572]: SPOTIFY: User informations: {"display_name":"tecnolabsf","external_urls":{"spotify":"https://open.spotify.com/user/tecnolabsf"},"href":"https://api.spotify.com/v1/users/tecnolabsf","id":"tecnolabsf","images":[],"type":"user","uri":"spotify:user:tecnolabsf","followers":{"href":null,"total":1},"country":"AR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"ventas@tecnolab.ar"} Apr 03 15:51:54 volumio volumio[572]: info: Spotify Successfully logged in Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 15:51:54 volumio volumio[572]: info: [1712159514587] CoreMusicLibrary::Adding element Spotify Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 15:51:54 volumio volumio[572]: Cannot find translation for source Spotify Apr 03 15:51:54 volumio volumio[572]: info: An error occurred while initializing Spotify Browsing facility: TypeError: Cannot read property 'broadcastMessage' of null Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 15:51:54 volumio volumio[572]: info: Received Get System Info Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 15:51:54 volumio volumio[572]: info: Discovery: Getting this device information Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:54 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:54 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 15:51:54 volumio go-librespot[2654]: time="2024-04-03T15:51:54Z" level=debug msg="completed challenge" Apr 03 15:51:54 volumio go-librespot[2654]: time="2024-04-03T15:51:54Z" level=debug msg="authenticated as tecnolabsf" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="authenticated as tecnolabsf" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 03 15:51:55 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="new websocket client" Apr 03 15:51:55 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:51:55 volumio volumio[572]: info: go-librespot daemon successfully initialized Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="dealer connection opened" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="stored credentials for tecnolabsf" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="received connection id: MWExNWViMjUtNjdjMC00MzY0LWE2NTQtNTYzYTcxYjU5MTZiK2RlYWxlcit0Y3A6Ly9ndWMzLWRlYWxlci1hLXNjbjUuZ3VjMy5zcG90aWZ5Lm5ldDo1NzAwKzE3MTgzOUExODhDMzYwNkQ3OTM0NjQzMTgzNTFCQjM5MzA3RURBNTNEOTMyMUEwNjIyNzg3MEUwOTEwNzYyMkY=" Apr 03 15:51:55 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:55 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 32. Apr 03 15:51:55 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:55 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:55 volumio volumio[2661]: Traceback (most recent call last): Apr 03 15:51:55 volumio volumio[2661]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:55 volumio volumio[2661]: from aiohttp import web Apr 03 15:51:55 volumio volumio[2661]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:55 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:55 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:55 volumio go-librespot[2654]: time="2024-04-03T15:51:55Z" level=debug msg="put connect state because NEW_DEVICE" Apr 03 15:51:56 volumio volumio[572]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Apr 03 15:51:56 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Apr 03 15:51:56 volumio volumio[572]: info: Creating Spotify config file Apr 03 15:51:56 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 15:51:56 volumio volumio[572]: info: Spotify config file written Apr 03 15:51:56 volumio sudo[2663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 15:51:56 volumio sudo[2663]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:51:56 volumio systemd[1]: Stopping go-librespot Daemon... Apr 03 15:51:56 volumio volumio[572]: info: Connection to go-librespot Websocket closed Apr 03 15:51:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 03 15:51:56 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Apr 03 15:51:56 volumio systemd[1]: Stopped go-librespot Daemon. Apr 03 15:51:56 volumio systemd[1]: Started go-librespot Daemon. Apr 03 15:51:56 volumio sudo[2663]: pam_unix(sudo:session): session closed for user root Apr 03 15:51:56 volumio go-librespot[2665]: Librespot-go daemon starting... Apr 03 15:51:56 volumio go-librespot[2665]: time="2024-04-03T15:51:56Z" level=info msg="generated new device id: eb2ec6131aa4aa1bc890430ec2f367d88ab3d329" Apr 03 15:51:56 volumio go-librespot[2665]: time="2024-04-03T15:51:56Z" level=debug msg="stored credentials found for tecnolabsf" Apr 03 15:51:56 volumio go-librespot[2665]: time="2024-04-03T15:51:56Z" level=debug msg="obtained new client token: AACvzJDjYy7kak608QRGsJ7DYNuDdhxSOt0R5gJSXH0wmL+9qQwF0nbGbcY5i/LYchYp21s3kpNofqoZsBRsuN195gOC/yajesxtI3bPM6eN+YqMMnFjm4F45APsuyBaGzymoFtG0+MSLfkm7YWgSHtsdb3iYmpCoG/SZPRa4f586ALYJxUxBtFwfkUw0rPpK/uHl3DLV1ZE8f/nwo+pfN6q4zPNYPbQ0G8MMI/nTMH7X7QPDjeFYZConuX0Bgo=" Apr 03 15:51:56 volumio go-librespot[2665]: time="2024-04-03T15:51:56Z" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 15:51:57 volumio go-librespot[2665]: time="2024-04-03T15:51:57Z" level=debug msg="completed keyexchange" Apr 03 15:51:57 volumio go-librespot[2665]: time="2024-04-03T15:51:57Z" level=debug msg="completed challenge" Apr 03 15:51:57 volumio go-librespot[2665]: time="2024-04-03T15:51:57Z" level=debug msg="authenticated as tecnolabsf" Apr 03 15:51:57 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:51:57 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 33. Apr 03 15:51:57 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:51:57 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:51:58 volumio volumio[2670]: Traceback (most recent call last): Apr 03 15:51:58 volumio volumio[2670]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:51:58 volumio volumio[2670]: from aiohttp import web Apr 03 15:51:58 volumio volumio[2670]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:51:58 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:51:58 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="authenticated as tecnolabsf" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 15:51:58 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:51:58 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="new websocket client" Apr 03 15:51:58 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 03 15:51:58 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:51:58 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:51:58 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:51:58 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="dealer connection opened" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 15:51:58 volumio volumio[572]: info: Spotify volume: 100 Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="received connection id: MmU2YjcxYTgtYmMwNy00ZGYyLTg5YzktM2QzYzBjZGY5YzRiK2RlYWxlcit0Y3A6Ly9ndWMzLWRlYWxlci1hLXNycWsuZ3VjMy5zcG90aWZ5Lm5ldDo1NzAwKzg2OUIwM0M4MUY1MjY3MzE5RTJBN0VGNDY4M0Y3MjE3NDNBMUQ5MERGQzc3NDU0MDVCNjlENERFNzUzQzVGMkU=" Apr 03 15:51:58 volumio go-librespot[2665]: time="2024-04-03T15:51:58Z" level=debug msg="put connect state because NEW_DEVICE" Apr 03 15:51:59 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:51:59 volumio go-librespot[2665]: time="2024-04-03T15:51:59Z" level=debug msg="new websocket client" Apr 03 15:51:59 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:51:59 volumio volumio[572]: info: go-librespot daemon successfully initialized Apr 03 15:52:00 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:00 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 34. Apr 03 15:52:00 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:00 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:00 volumio volumio[2671]: Traceback (most recent call last): Apr 03 15:52:00 volumio volumio[2671]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:00 volumio volumio[2671]: from aiohttp import web Apr 03 15:52:00 volumio volumio[2671]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:00 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:00 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:01 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:52:01 volumio volumio[572]: info: Spotify volume: 100 Apr 03 15:52:01 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 03 15:52:01 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:01 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:01 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:52:01 volumio volumio[572]: SPOTIFY: SPOTIFY VOLUME 100 Apr 03 15:52:01 volumio volumio[572]: SPOTIFY: VOLUMIO VOLUME 41 Apr 03 15:52:01 volumio volumio[572]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 15:52:01 volumio volumio[572]: info: Setting Spotify Volume from Volumio: 41 Apr 03 15:52:02 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:52:02 volumio volumio[572]: info: Spotify volume: 100 Apr 03 15:52:02 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 03 15:52:02 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:52:02 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:02 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:02 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:52:02 volumio volumio[572]: SPOTIFY: SPOTIFY VOLUME 100 Apr 03 15:52:02 volumio volumio[572]: SPOTIFY: VOLUMIO VOLUME 41 Apr 03 15:52:02 volumio volumio[572]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 15:52:02 volumio volumio[572]: info: Setting Spotify Volume from Volumio: 41 Apr 03 15:52:02 volumio go-librespot[2665]: time="2024-04-03T15:52:02Z" level=debug msg="new websocket client" Apr 03 15:52:02 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:52:02 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:02 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 35. Apr 03 15:52:02 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:02 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:02 volumio volumio[2672]: Traceback (most recent call last): Apr 03 15:52:02 volumio volumio[2672]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:02 volumio volumio[2672]: from aiohttp import web Apr 03 15:52:02 volumio volumio[2672]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:02 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:02 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:03 volumio volumio[572]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Apr 03 15:52:03 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Apr 03 15:52:03 volumio volumio[572]: info: Creating Spotify config file Apr 03 15:52:03 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 15:52:03 volumio volumio[572]: info: Spotify config file written Apr 03 15:52:03 volumio sudo[2674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 15:52:03 volumio sudo[2674]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 15:52:03 volumio systemd[1]: Stopping go-librespot Daemon... Apr 03 15:52:03 volumio volumio[572]: info: Connection to go-librespot Websocket closed Apr 03 15:52:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 03 15:52:03 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Apr 03 15:52:03 volumio systemd[1]: Stopped go-librespot Daemon. Apr 03 15:52:03 volumio volumio[572]: info: Connection to go-librespot Websocket closed Apr 03 15:52:03 volumio systemd[1]: Started go-librespot Daemon. Apr 03 15:52:03 volumio go-librespot[2676]: Librespot-go daemon starting... Apr 03 15:52:03 volumio sudo[2674]: pam_unix(sudo:session): session closed for user root Apr 03 15:52:03 volumio go-librespot[2676]: time="2024-04-03T15:52:03Z" level=info msg="generated new device id: 437735f5fa5677a6084240ef1c606044a2b9f234" Apr 03 15:52:03 volumio go-librespot[2676]: time="2024-04-03T15:52:03Z" level=debug msg="stored credentials found for tecnolabsf" Apr 03 15:52:03 volumio volumio[572]: SPOTIFY: SETTING SPOTIFY VOLUME 41 Apr 03 15:52:03 volumio volumio[572]: info: Sending Spotify command with payload to local API: /player/volume Apr 03 15:52:04 volumio go-librespot[2676]: time="2024-04-03T15:52:04Z" level=debug msg="obtained new client token: AADKzTJkRzDx7WvdJDDh7rmAHSZQ/xC45SjQhLngt7fQjlAU6kJy2+EvC8tNI/lHS4Ov7BagT1GsL4zZkIUGmg3sK8lUT2CoPeCIR/leGypyEZBrGGbS53uvwBavrazoUglpWYoijTrydg3XUFLZnscRaj7lDfzKsr6oKYRLD6NSfakpnrYPJiNv8aUyWJJ0sIp1VELWPYJ7vdhnbjQtVYZZ4dOy5VFjwD9ke3dblF9d5x1VPLt1q8fezTX0sOQ=" Apr 03 15:52:04 volumio go-librespot[2676]: time="2024-04-03T15:52:04Z" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 15:52:04 volumio go-librespot[2676]: time="2024-04-03T15:52:04Z" level=debug msg="completed keyexchange" Apr 03 15:52:04 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:04 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 36. Apr 03 15:52:04 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:04 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:04 volumio volumio[2681]: Traceback (most recent call last): Apr 03 15:52:04 volumio volumio[2681]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:04 volumio volumio[2681]: from aiohttp import web Apr 03 15:52:04 volumio volumio[2681]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:04 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:04 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:05 volumio go-librespot[2676]: time="2024-04-03T15:52:05Z" level=debug msg="completed challenge" Apr 03 15:52:05 volumio go-librespot[2676]: time="2024-04-03T15:52:05Z" level=debug msg="authenticated as tecnolabsf" Apr 03 15:52:05 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:52:05 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 03 15:52:05 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:05 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:05 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:52:05 volumio go-librespot[2676]: time="2024-04-03T15:52:05Z" level=debug msg="authenticated as tecnolabsf" Apr 03 15:52:05 volumio go-librespot[2676]: time="2024-04-03T15:52:05Z" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 03 15:52:05 volumio go-librespot[2676]: time="2024-04-03T15:52:05Z" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="dealer connection opened" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="update volume to 26869/65535" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=error msg="failed put state after volume change" error="put state request failed with status 400: Require at least one of callbackUrl or X-Spotify-Connection-Id" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=trace msg="emitting websocket event: volume" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="received connection id: YTM1NzE0YzYtMjMwMC00OTY2LWE5OWItZGFkZTcxYjhiY2QyK2RlYWxlcit0Y3A6Ly9ndWMzLWRlYWxlci1hLXQwdmYuZ3VjMy5zcG90aWZ5Lm5ldDo1NzAwK0YxRDJDM0MxQzE2RTY4QkQ0MjBENTgwNzFEREQxMzZDNkREREI3MkU5RTM5RjVCOEY2QURDOTZDQjJCM0EyNEQ=" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="put connect state because NEW_DEVICE" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 03 15:52:06 volumio volumio[572]: info: Spotify volume: 41 Apr 03 15:52:06 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:52:06 volumio go-librespot[2676]: time="2024-04-03T15:52:06Z" level=debug msg="new websocket client" Apr 03 15:52:06 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:52:06 volumio volumio[572]: info: go-librespot daemon successfully initialized Apr 03 15:52:06 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:06 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:06 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:06 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 37. Apr 03 15:52:06 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:07 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:07 volumio volumio[2684]: Traceback (most recent call last): Apr 03 15:52:07 volumio volumio[2684]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:07 volumio volumio[2684]: from aiohttp import web Apr 03 15:52:07 volumio volumio[2684]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:07 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:07 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:09 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:09 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 38. Apr 03 15:52:09 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:09 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:09 volumio volumio[2686]: Traceback (most recent call last): Apr 03 15:52:09 volumio volumio[2686]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:09 volumio volumio[2686]: from aiohttp import web Apr 03 15:52:09 volumio volumio[2686]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:09 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:09 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:09 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:52:09 volumio volumio[572]: info: Spotify volume: 41 Apr 03 15:52:09 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 03 15:52:09 volumio volumio[572]: info: Initializing connection to go-librespot Websocket Apr 03 15:52:09 volumio go-librespot[2676]: time="2024-04-03T15:52:09Z" level=debug msg="new websocket client" Apr 03 15:52:09 volumio volumio[572]: info: Connection to go-librespot Websocket established Apr 03 15:52:09 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:09 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:09 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 15:52:10 volumio volumio[572]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 03 15:52:10 volumio volumio[572]: error: Failed callmethod call: TypeError: Cannot read property 'broadcastMessage' of null Apr 03 15:52:10 volumio volumio[572]: info: Received Get System Version Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 15:52:10 volumio volumio[572]: info: Received Get System Info Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 15:52:10 volumio volumio[572]: info: Discovery: Getting this device information Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:10 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:10 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 15:52:11 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:11 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 39. Apr 03 15:52:11 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:11 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:11 volumio volumio[2688]: Traceback (most recent call last): Apr 03 15:52:11 volumio volumio[2688]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:11 volumio volumio[2688]: from aiohttp import web Apr 03 15:52:11 volumio volumio[2688]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:11 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:11 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:12 volumio volumio[572]: info: Getting Spotify volume Apr 03 15:52:12 volumio volumio[572]: info: Spotify volume: 41 Apr 03 15:52:12 volumio volumio[572]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 03 15:52:12 volumio volumio[572]: info: CoreCommandRouter::volumioGetState Apr 03 15:52:12 volumio volumio[572]: info: CorePlayQueue::getTrack 0 Apr 03 15:52:12 volumio volumio[572]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 15:52:13 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:13 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 40. Apr 03 15:52:13 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:13 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:13 volumio volumio[2736]: Traceback (most recent call last): Apr 03 15:52:13 volumio volumio[2736]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:13 volumio volumio[2736]: from aiohttp import web Apr 03 15:52:13 volumio volumio[2736]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:13 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:13 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:14 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:52:15 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:15 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 41. Apr 03 15:52:15 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:15 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:16 volumio volumio[2737]: Traceback (most recent call last): Apr 03 15:52:16 volumio volumio[2737]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:16 volumio volumio[2737]: from aiohttp import web Apr 03 15:52:16 volumio volumio[2737]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 42. Apr 03 15:52:18 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:18 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:18 volumio volumio[2738]: Traceback (most recent call last): Apr 03 15:52:18 volumio volumio[2738]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:18 volumio volumio[2738]: from aiohttp import web Apr 03 15:52:18 volumio volumio[2738]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 43. Apr 03 15:52:20 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:20 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:20 volumio volumio[2739]: Traceback (most recent call last): Apr 03 15:52:20 volumio volumio[2739]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:20 volumio volumio[2739]: from aiohttp import web Apr 03 15:52:20 volumio volumio[2739]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:20 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:20 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:21 volumio ntpd[1121]: ntpd exiting on signal 15 (Terminated) Apr 03 15:52:21 volumio ntpd[1121]: 162.159.200.123 local addr 192.168.88.93 -> Apr 03 15:52:21 volumio ntpd[1121]: 168.96.251.195 local addr 192.168.88.93 -> Apr 03 15:52:21 volumio ntpd[1121]: 162.159.200.1 local addr 192.168.88.93 -> Apr 03 15:52:21 volumio ntpd[1121]: 200.11.116.10 local addr 192.168.88.93 -> Apr 03 15:52:21 volumio systemd[1]: Stopping Network Time Service... Apr 03 15:52:22 volumio systemd[1]: ntp.service: Succeeded. Apr 03 15:52:22 volumio systemd[1]: Stopped Network Time Service. Apr 03 15:52:22 volumio systemd[1]: Starting Network Time Service... Apr 03 15:52:22 volumio ntpd[2771]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 03 15:52:22 volumio ntpd[2771]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 03 15:52:22 volumio systemd[1]: Started Network Time Service. Apr 03 15:52:22 volumio ntpd[2777]: proto: precision = 0.044 usec (-24) Apr 03 15:52:22 volumio ntpd[2777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 03 15:52:22 volumio ntpd[2777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 03 15:52:22 volumio ntpd[2777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 463 days ago Apr 03 15:52:22 volumio ntpd[2777]: Listen and drop on 0 v6wildcard [::]:123 Apr 03 15:52:22 volumio ntpd[2777]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 03 15:52:22 volumio ntpd[2777]: Listen normally on 2 lo 127.0.0.1:123 Apr 03 15:52:22 volumio ntpd[2777]: Listen normally on 3 eth0 192.168.88.93:123 Apr 03 15:52:22 volumio ntpd[2777]: Listening on routing socket on fd #20 for interface updates Apr 03 15:52:22 volumio ntpd[2777]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 03 15:52:22 volumio ntpd[2777]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 03 15:52:22 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:22 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 44. Apr 03 15:52:22 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:22 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:22 volumio volumio[2779]: Traceback (most recent call last): Apr 03 15:52:22 volumio volumio[2779]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:22 volumio volumio[2779]: from aiohttp import web Apr 03 15:52:22 volumio volumio[2779]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:22 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:22 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:23 volumio ntpd[2777]: Soliciting pool server 162.159.200.123 Apr 03 15:52:24 volumio ntpd[2777]: Soliciting pool server 162.159.200.1 Apr 03 15:52:24 volumio ntpd[2777]: Soliciting pool server 168.96.251.195 Apr 03 15:52:24 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:24 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 45. Apr 03 15:52:24 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:25 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:25 volumio volumio[2780]: Traceback (most recent call last): Apr 03 15:52:25 volumio volumio[2780]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:25 volumio volumio[2780]: from aiohttp import web Apr 03 15:52:25 volumio volumio[2780]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:25 volumio ntpd[2777]: Soliciting pool server 200.11.116.10 Apr 03 15:52:25 volumio ntpd[2777]: Soliciting pool server 200.11.116.10 Apr 03 15:52:25 volumio ntpd[2777]: Soliciting pool server 2606:4700:f1::1 Apr 03 15:52:25 volumio nmbd[461]: [2024/04/03 15:52:25.515663, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 15:52:25 volumio nmbd[461]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.88.93 for name WORKGROUP<1d>. Apr 03 15:52:25 volumio nmbd[461]: This response was from IP 192.168.88.250, reporting an IP address of 192.168.88.250. Apr 03 15:52:27 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:27 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 46. Apr 03 15:52:27 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:27 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:27 volumio volumio[2783]: Traceback (most recent call last): Apr 03 15:52:27 volumio volumio[2783]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:27 volumio volumio[2783]: from aiohttp import web Apr 03 15:52:27 volumio volumio[2783]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:27 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:27 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:29 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Apr 03 15:52:29 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 47. Apr 03 15:52:29 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 03 15:52:29 volumio systemd[1]: Started FusionDsp Daemon. Apr 03 15:52:29 volumio volumio[2784]: Traceback (most recent call last): Apr 03 15:52:29 volumio volumio[2784]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Apr 03 15:52:29 volumio volumio[2784]: from aiohttp import web Apr 03 15:52:29 volumio volumio[2784]: ModuleNotFoundError: No module named 'aiohttp' Apr 03 15:52:29 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Apr 03 15:52:29 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 03 15:52:30 volumio volumio[572]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Apr 03 15:52:30 volumio volumio[572]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Apr 03 15:52:30 volumio volumio[572]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 03 15:52:30 volumio volumio[572]: info: FusionDsp - Nulleq applied Apr 03 15:52:30 volumio volumio[572]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 15:52:30 volumio volumio[572]: info: CoreCommandRouter::Close All Modals sent Apr 03 15:52:30 volumio volumio[572]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 15:52:30 volumio volumio[572]: TypeError: Cannot read property 'broadcastMessage' of null Apr 03 15:52:30 volumio volumio[572]: at /volumio/app/index.js:1509:32 Apr 03 15:52:30 volumio volumio[572]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Apr 03 15:52:30 volumio volumio[572]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Apr 03 15:52:30 volumio volumio[572]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1507:13) Apr 03 15:52:30 volumio volumio[572]: at CoreCommandRouter.closeModals (/volumio/app/index.js:1929:15) Apr 03 15:52:30 volumio volumio[572]: at Timeout._onTimeout (/data/plugins/audio_interface/fusiondsp/index.js:1822:24) Apr 03 15:52:30 volumio volumio[572]: at listOnTimeout (internal/timers.js:557:17) Apr 03 15:52:30 volumio volumio[572]: at processTimers (internal/timers.js:500:7) Apr 03 15:52:30 volumio volumio[572]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 15:52:30 volumio sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-03 15:51 Apr 03 15:52:30 volumio sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"